{"level":"warn","ts":"2026-05-08T22:03:58.081867Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-05-08T22:03:58.081967Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.3:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.3:2380","--initial-cluster=instance=https://199.204.45.3:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.3:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.3:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]}
{"level":"warn","ts":"2026-05-08T22:03:58.08206Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-05-08T22:03:58.082083Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.3:2380"]}
{"level":"info","ts":"2026-05-08T22:03:58.082103Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-05-08T22:03:58.082946Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.3:2379"]}
{"level":"info","ts":"2026-05-08T22:03:58.083067Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.3:2380"],"listen-peer-urls":["https://199.204.45.3:2380"],"advertise-client-urls":["https://199.204.45.3:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.3:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.3:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"}
{"level":"info","ts":"2026-05-08T22:03:58.087812Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.52121ms"}
{"level":"info","ts":"2026-05-08T22:03:58.095601Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"597401b06ce1cf3d","cluster-id":"dfc54657ad8a2432"}
{"level":"info","ts":"2026-05-08T22:03:58.095716Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d switched to configuration voters=()"}
{"level":"info","ts":"2026-05-08T22:03:58.09575Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d became follower at term 0"}
{"level":"info","ts":"2026-05-08T22:03:58.095776Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 597401b06ce1cf3d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-05-08T22:03:58.095795Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d became follower at term 1"}
{"level":"info","ts":"2026-05-08T22:03:58.095856Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d switched to configuration voters=(6445778823926632253)"}
{"level":"warn","ts":"2026-05-08T22:03:58.105817Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-05-08T22:03:58.112287Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-05-08T22:03:58.114017Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"}
{"level":"info","ts":"2026-05-08T22:03:58.116135Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"597401b06ce1cf3d","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-05-08T22:03:58.116255Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"}
{"level":"info","ts":"2026-05-08T22:03:58.116335Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"}
{"level":"info","ts":"2026-05-08T22:03:58.116349Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"}
{"level":"info","ts":"2026-05-08T22:03:58.118316Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"597401b06ce1cf3d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-05-08T22:03:58.12064Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d switched to configuration voters=(6445778823926632253)"}
{"level":"info","ts":"2026-05-08T22:03:58.120748Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"dfc54657ad8a2432","local-member-id":"597401b06ce1cf3d","added-peer-id":"597401b06ce1cf3d","added-peer-peer-urls":["https://199.204.45.3:2380"]}
{"level":"info","ts":"2026-05-08T22:03:58.121591Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-05-08T22:03:58.121632Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.3:2380"}
{"level":"info","ts":"2026-05-08T22:03:58.121659Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.3:2380"}
{"level":"info","ts":"2026-05-08T22:03:58.121801Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"597401b06ce1cf3d","initial-advertise-peer-urls":["https://199.204.45.3:2380"],"listen-peer-urls":["https://199.204.45.3:2380"],"advertise-client-urls":["https://199.204.45.3:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.3:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-05-08T22:03:58.121833Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-05-08T22:03:58.99729Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d is starting a new election at term 1"}
{"level":"info","ts":"2026-05-08T22:03:58.997346Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d became pre-candidate at term 1"}
{"level":"info","ts":"2026-05-08T22:03:58.997379Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d received MsgPreVoteResp from 597401b06ce1cf3d at term 1"}
{"level":"info","ts":"2026-05-08T22:03:58.997397Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d became candidate at term 2"}
{"level":"info","ts":"2026-05-08T22:03:58.997408Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d received MsgVoteResp from 597401b06ce1cf3d at term 2"}
{"level":"info","ts":"2026-05-08T22:03:58.997424Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d became leader at term 2"}
{"level":"info","ts":"2026-05-08T22:03:58.997436Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 597401b06ce1cf3d elected leader 597401b06ce1cf3d at term 2"}
{"level":"info","ts":"2026-05-08T22:03:59.005378Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-08T22:03:59.006117Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"597401b06ce1cf3d","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.3:2379]}","request-path":"/0/members/597401b06ce1cf3d/attributes","cluster-id":"dfc54657ad8a2432","publish-timeout":"7s"}
{"level":"info","ts":"2026-05-08T22:03:59.006147Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-05-08T22:03:59.006315Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-05-08T22:03:59.006456Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-05-08T22:03:59.006535Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-05-08T22:03:59.008279Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"dfc54657ad8a2432","local-member-id":"597401b06ce1cf3d","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-08T22:03:59.008369Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-08T22:03:59.008394Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-08T22:03:59.010332Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.3:2379"}
{"level":"info","ts":"2026-05-08T22:03:59.010997Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-05-08T22:04:00.378685Z","caller":"traceutil/trace.go:171","msg":"trace[198295282] transaction","detail":"{read_only:false; response_revision:2; number_of_response:1; }","duration":"102.908085ms","start":"2026-05-08T22:04:00.275742Z","end":"2026-05-08T22:04:00.378651Z","steps":["trace[198295282] 'process raft request'  (duration: 102.730857ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T22:04:00.378693Z","caller":"traceutil/trace.go:171","msg":"trace[377371150] linearizableReadLoop","detail":"{readStateIndex:5; appliedIndex:5; }","duration":"101.874685ms","start":"2026-05-08T22:04:00.276789Z","end":"2026-05-08T22:04:00.378664Z","steps":["trace[377371150] 'read index received'  (duration: 101.864235ms)","trace[377371150] 'applied index is now lower than readState.Index'  (duration: 7.95µs)"],"step_count":2}
{"level":"warn","ts":"2026-05-08T22:04:00.378884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.049123ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-05-08T22:04:00.378974Z","caller":"traceutil/trace.go:171","msg":"trace[26155170] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:0; response_revision:2; }","duration":"102.180232ms","start":"2026-05-08T22:04:00.276777Z","end":"2026-05-08T22:04:00.378957Z","steps":["trace[26155170] 'agreement among raft nodes before linearized reading'  (duration: 101.980904ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T22:04:00.74904Z","caller":"traceutil/trace.go:171","msg":"trace[457490802] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"402.790359ms","start":"2026-05-08T22:04:00.346217Z","end":"2026-05-08T22:04:00.749007Z","steps":["trace[457490802] 'process raft request'  (duration: 402.599051ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T22:04:00.749311Z","caller":"traceutil/trace.go:171","msg":"trace[1298302375] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"402.905729ms","start":"2026-05-08T22:04:00.346386Z","end":"2026-05-08T22:04:00.749292Z","steps":["trace[1298302375] 'process raft request'  (duration: 402.598311ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T22:04:00.749421Z","caller":"traceutil/trace.go:171","msg":"trace[2104445796] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"402.945349ms","start":"2026-05-08T22:04:00.346426Z","end":"2026-05-08T22:04:00.749371Z","steps":["trace[2104445796] 'process raft request'  (duration: 402.698861ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T22:04:00.749508Z","caller":"traceutil/trace.go:171","msg":"trace[1452141278] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"402.569932ms","start":"2026-05-08T22:04:00.346933Z","end":"2026-05-08T22:04:00.749503Z","steps":["trace[1452141278] 'process raft request'  (duration: 402.378644ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T22:04:00.74958Z","caller":"traceutil/trace.go:171","msg":"trace[1753367886] linearizableReadLoop","detail":"{readStateIndex:13; appliedIndex:5; }","duration":"370.774478ms","start":"2026-05-08T22:04:00.37878Z","end":"2026-05-08T22:04:00.749555Z","steps":["trace[1753367886] 'read index received'  (duration: 370.052774ms)","trace[1753367886] 'applied index is now lower than readState.Index'  (duration: 720.774µs)"],"step_count":2}
{"level":"info","ts":"2026-05-08T22:04:00.749655Z","caller":"traceutil/trace.go:171","msg":"trace[160254848] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"377.070044ms","start":"2026-05-08T22:04:00.372565Z","end":"2026-05-08T22:04:00.749635Z","steps":["trace[160254848] 'process raft request'  (duration: 376.921105ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T22:04:00.749681Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T22:04:00.346925Z","time spent":"402.595612ms","remote":"127.0.0.1:51276","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":971,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/apiregistration.k8s.io/apiservices/v1.authentication.k8s.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiregistration.k8s.io/apiservices/v1.authentication.k8s.io\" value_size:894 >> failure:<>"}
{"level":"warn","ts":"2026-05-08T22:04:00.749812Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"402.528062ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"}
{"level":"warn","ts":"2026-05-08T22:04:00.749855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"472.093598ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:0 size:4"}
{"level":"warn","ts":"2026-05-08T22:04:00.749894Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T22:04:00.346375Z","time spent":"402.985088ms","remote":"127.0.0.1:51276","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/apiregistration.k8s.io/apiservices/v1.admissionregistration.k8s.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiregistration.k8s.io/apiservices/v1.admissionregistration.k8s.io\" value_size:908 >> failure:<>"}
{"level":"info","ts":"2026-05-08T22:04:00.74989Z","caller":"traceutil/trace.go:171","msg":"trace[707054752] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:10; }","duration":"402.602752ms","start":"2026-05-08T22:04:00.347246Z","end":"2026-05-08T22:04:00.749848Z","steps":["trace[707054752] 'agreement among raft nodes before linearized reading'  (duration: 402.464303ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T22:04:00.749908Z","caller":"traceutil/trace.go:171","msg":"trace[712399722] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:10; }","duration":"472.172487ms","start":"2026-05-08T22:04:00.277723Z","end":"2026-05-08T22:04:00.749896Z","steps":["trace[712399722] 'agreement among raft nodes before linearized reading'  (duration: 472.070528ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T22:04:00.749903Z","caller":"traceutil/trace.go:171","msg":"trace[1160495877] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"382.675885ms","start":"2026-05-08T22:04:00.367217Z","end":"2026-05-08T22:04:00.749893Z","steps":["trace[1160495877] 'process raft request'  (duration: 382.20283ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T22:04:00.74986Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T22:04:00.372552Z","time spent":"377.142563ms","remote":"127.0.0.1:50922","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3157,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:0 > success:<request_put:<key:\"/registry/minions/instance\" value_size:3123 >> failure:<>"}
{"level":"warn","ts":"2026-05-08T22:04:00.749965Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T22:04:00.346377Z","time spent":"403.106867ms","remote":"127.0.0.1:51276","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/apiregistration.k8s.io/apiservices/v1.apiextensions.k8s.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiregistration.k8s.io/apiservices/v1.apiextensions.k8s.io\" value_size:892 >> failure:<>"}
{"level":"warn","ts":"2026-05-08T22:04:00.749933Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T22:04:00.347239Z","time spent":"402.683121ms","remote":"127.0.0.1:50798","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":27,"request content":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" "}
{"level":"warn","ts":"2026-05-08T22:04:00.750176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"404.528575ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"}
{"level":"warn","ts":"2026-05-08T22:04:00.750225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"472.632773ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-05-08T22:04:00.750247Z","caller":"traceutil/trace.go:171","msg":"trace[1488917166] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:0; response_revision:10; }","duration":"472.670683ms","start":"2026-05-08T22:04:00.277569Z","end":"2026-05-08T22:04:00.75024Z","steps":["trace[1488917166] 'agreement among raft nodes before linearized reading'  (duration: 472.627864ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T22:04:00.750271Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T22:04:00.277565Z","time spent":"472.702063ms","remote":"127.0.0.1:51024","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":27,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-05-08T22:04:00.750271Z","caller":"traceutil/trace.go:171","msg":"trace[568850050] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"390.617636ms","start":"2026-05-08T22:04:00.359623Z","end":"2026-05-08T22:04:00.750241Z","steps":["trace[568850050] 'process raft request'  (duration: 389.724804ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T22:04:00.750088Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T22:04:00.367199Z","time spent":"382.771185ms","remote":"127.0.0.1:51020","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":849,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/certificatesigningrequests/csr-76lh4\" mod_revision:0 > success:<request_put:<key:\"/registry/certificatesigningrequests/csr-76lh4\" value_size:795 >> failure:<>"}
{"level":"warn","ts":"2026-05-08T22:04:00.750422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"473.577875ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3169"}
{"level":"warn","ts":"2026-05-08T22:04:00.75041Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T22:04:00.359599Z","time spent":"390.739955ms","remote":"127.0.0.1:51198","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":698,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/prioritylevelconfigurations/system\" mod_revision:0 > success:<request_put:<key:\"/registry/prioritylevelconfigurations/system\" value_size:646 >> failure:<>"}
{"level":"warn","ts":"2026-05-08T22:04:00.749948Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T22:04:00.277719Z","time spent":"472.221577ms","remote":"127.0.0.1:51024","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":0,"response size":27,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-05-08T22:04:00.750442Z","caller":"traceutil/trace.go:171","msg":"trace[98319816] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:10; }","duration":"473.608164ms","start":"2026-05-08T22:04:00.276828Z","end":"2026-05-08T22:04:00.750436Z","steps":["trace[98319816] 'agreement among raft nodes before linearized reading'  (duration: 473.564795ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T22:04:00.750463Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T22:04:00.276821Z","time spent":"473.638064ms","remote":"127.0.0.1:50922","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3192,"request content":"key:\"/registry/minions/instance\" "}
{"level":"warn","ts":"2026-05-08T22:04:00.749871Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T22:04:00.346193Z","time spent":"402.918567ms","remote":"127.0.0.1:51276","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/apiregistration.k8s.io/apiservices/v1.\" mod_revision:0 > success:<request_put:<key:\"/registry/apiregistration.k8s.io/apiservices/v1.\" value_size:827 >> failure:<>"}
{"level":"warn","ts":"2026-05-08T22:04:00.750659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.807143ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.3\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-05-08T22:04:00.750694Z","caller":"traceutil/trace.go:171","msg":"trace[718659672] range","detail":"{range_begin:/registry/masterleases/199.204.45.3; range_end:; response_count:0; response_revision:10; }","duration":"405.888923ms","start":"2026-05-08T22:04:00.344794Z","end":"2026-05-08T22:04:00.750683Z","steps":["trace[718659672] 'agreement among raft nodes before linearized reading'  (duration: 405.822194ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T22:04:00.750726Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T22:04:00.344772Z","time spent":"405.947783ms","remote":"127.0.0.1:50732","response type":"/etcdserverpb.KV/Range","request count":0,"request size":37,"response count":0,"response size":27,"request content":"key:\"/registry/masterleases/199.204.45.3\" "}
{"level":"info","ts":"2026-05-08T22:04:00.749259Z","caller":"traceutil/trace.go:171","msg":"trace[1155889628] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"402.908269ms","start":"2026-05-08T22:04:00.346293Z","end":"2026-05-08T22:04:00.749202Z","steps":["trace[1155889628] 'process raft request'  (duration: 402.66127ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T22:04:00.750858Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T22:04:00.346242Z","time spent":"404.590064ms","remote":"127.0.0.1:51276","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":920,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/apiregistration.k8s.io/apiservices/v1.apps\" mod_revision:0 > success:<request_put:<key:\"/registry/apiregistration.k8s.io/apiservices/v1.apps\" value_size:860 >> failure:<>"}
{"level":"warn","ts":"2026-05-08T22:04:00.751396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.123843ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-05-08T22:04:00.75144Z","caller":"traceutil/trace.go:171","msg":"trace[1577577331] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"354.235791ms","start":"2026-05-08T22:04:00.397194Z","end":"2026-05-08T22:04:00.75143Z","steps":["trace[1577577331] 'agreement among raft nodes before linearized reading'  (duration: 354.123132ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T22:04:00.751479Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T22:04:00.39718Z","time spent":"354.285661ms","remote":"127.0.0.1:50844","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "}
{"level":"info","ts":"2026-05-08T22:04:00.751636Z","caller":"traceutil/trace.go:171","msg":"trace[849369119] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"370.422261ms","start":"2026-05-08T22:04:00.381202Z","end":"2026-05-08T22:04:00.751624Z","steps":["trace[849369119] 'process raft request'  (duration: 370.038034ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T22:04:00.751897Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T22:04:00.381185Z","time spent":"370.48728ms","remote":"127.0.0.1:50760","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":100,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/ranges/serviceips\" mod_revision:0 > success:<request_put:<key:\"/registry/ranges/serviceips\" value_size:67 >> failure:<request_range:<key:\"/registry/ranges/serviceips\" > >"}
{"level":"warn","ts":"2026-05-08T22:04:00.752054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.740653ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-05-08T22:04:00.75209Z","caller":"traceutil/trace.go:171","msg":"trace[1851879033] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"335.806551ms","start":"2026-05-08T22:04:00.416274Z","end":"2026-05-08T22:04:00.752081Z","steps":["trace[1851879033] 'agreement among raft nodes before linearized reading'  (duration: 335.754142ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T22:04:00.752117Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T22:04:00.416261Z","time spent":"335.850341ms","remote":"127.0.0.1:50844","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "}
{"level":"info","ts":"2026-05-08T22:04:00.750217Z","caller":"traceutil/trace.go:171","msg":"trace[681504430] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"404.579735ms","start":"2026-05-08T22:04:00.345622Z","end":"2026-05-08T22:04:00.750202Z","steps":["trace[681504430] 'agreement among raft nodes before linearized reading'  (duration: 404.502235ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T22:04:00.753717Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T22:04:00.345612Z","time spent":"408.086984ms","remote":"127.0.0.1:50844","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "}
{"level":"info","ts":"2026-05-08T22:04:27.422714Z","caller":"traceutil/trace.go:171","msg":"trace[664069688] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"149.925513ms","start":"2026-05-08T22:04:27.272756Z","end":"2026-05-08T22:04:27.422682Z","steps":["trace[664069688] 'process raft request'  (duration: 113.251261ms)","trace[664069688] 'compare'  (duration: 36.479869ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T22:04:27.425287Z","caller":"traceutil/trace.go:171","msg":"trace[1234040559] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"148.645576ms","start":"2026-05-08T22:04:27.276619Z","end":"2026-05-08T22:04:27.425265Z","steps":["trace[1234040559] 'process raft request'  (duration: 148.411543ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T22:04:27.425453Z","caller":"traceutil/trace.go:171","msg":"trace[646184539] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"127.072255ms","start":"2026-05-08T22:04:27.298356Z","end":"2026-05-08T22:04:27.425428Z","steps":["trace[646184539] 'process raft request'  (duration: 126.844582ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T22:04:33.61341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.155215ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14933265703580275971 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" mod_revision:0 > success:<request_put:<key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" value_size:729 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-05-08T22:04:33.613604Z","caller":"traceutil/trace.go:171","msg":"trace[968078449] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"444.632254ms","start":"2026-05-08T22:04:33.168916Z","end":"2026-05-08T22:04:33.613549Z","steps":["trace[968078449] 'process raft request'  (duration: 252.008591ms)","trace[968078449] 'compare'  (duration: 191.996532ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-08T22:04:33.613694Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T22:04:33.168888Z","time spent":"444.769176ms","remote":"127.0.0.1:50948","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":818,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" mod_revision:0 > success:<request_put:<key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" value_size:729 >> failure:<>"}
{"level":"warn","ts":"2026-05-08T22:04:48.595224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.642039ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-05-08T22:04:48.595387Z","caller":"traceutil/trace.go:171","msg":"trace[825775166] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:773; }","duration":"107.850894ms","start":"2026-05-08T22:04:48.487522Z","end":"2026-05-08T22:04:48.595373Z","steps":["trace[825775166] 'range keys from in-memory index tree'  (duration: 107.488365ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T22:05:33.564989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.598436ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"warn","ts":"2026-05-08T22:05:33.565031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.122456ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"info","ts":"2026-05-08T22:05:33.565085Z","caller":"traceutil/trace.go:171","msg":"trace[714362876] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1320; }","duration":"101.752192ms","start":"2026-05-08T22:05:33.463313Z","end":"2026-05-08T22:05:33.565065Z","steps":["trace[714362876] 'range keys from in-memory index tree'  (duration: 101.416218ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T22:05:33.5651Z","caller":"traceutil/trace.go:171","msg":"trace[1709299509] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1320; }","duration":"101.23797ms","start":"2026-05-08T22:05:33.463845Z","end":"2026-05-08T22:05:33.565083Z","steps":["trace[1709299509] 'range keys from in-memory index tree'  (duration: 100.98675ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T22:06:03.900385Z","caller":"traceutil/trace.go:171","msg":"trace[1143258061] transaction","detail":"{read_only:false; response_revision:1845; number_of_response:1; }","duration":"150.76901ms","start":"2026-05-08T22:06:03.749588Z","end":"2026-05-08T22:06:03.900357Z","steps":["trace[1143258061] 'process raft request'  (duration: 150.640104ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T22:06:03.999975Z","caller":"traceutil/trace.go:171","msg":"trace[418907114] transaction","detail":"{read_only:false; response_revision:1846; number_of_response:1; }","duration":"248.580076ms","start":"2026-05-08T22:06:03.751363Z","end":"2026-05-08T22:06:03.999943Z","steps":["trace[418907114] 'process raft request'  (duration: 232.900314ms)","trace[418907114] 'compare'  (duration: 15.43177ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T22:06:04.000321Z","caller":"traceutil/trace.go:171","msg":"trace[1500103417] transaction","detail":"{read_only:false; response_revision:1847; number_of_response:1; }","duration":"195.536497ms","start":"2026-05-08T22:06:03.804727Z","end":"2026-05-08T22:06:04.000264Z","steps":["trace[1500103417] 'process raft request'  (duration: 195.153999ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T22:06:34.816072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.262979ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-08T22:06:34.816174Z","caller":"traceutil/trace.go:171","msg":"trace[55763491] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:2071; }","duration":"102.425007ms","start":"2026-05-08T22:06:34.71373Z","end":"2026-05-08T22:06:34.816155Z","steps":["trace[55763491] 'count revisions from in-memory index tree'  (duration: 102.174094ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T22:06:35.576681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.660307ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-05-08T22:06:35.576786Z","caller":"traceutil/trace.go:171","msg":"trace[2000897131] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2076; }","duration":"101.840985ms","start":"2026-05-08T22:06:35.474922Z","end":"2026-05-08T22:06:35.576763Z","steps":["trace[2000897131] 'range keys from in-memory index tree'  (duration: 101.445606ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T22:08:15.768759Z","caller":"traceutil/trace.go:171","msg":"trace[1164878007] transaction","detail":"{read_only:false; response_revision:2724; number_of_response:1; }","duration":"125.897551ms","start":"2026-05-08T22:08:15.642836Z","end":"2026-05-08T22:08:15.768733Z","steps":["trace[1164878007] 'process raft request'  (duration: 125.739733ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T22:08:16.109673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.323386ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-05-08T22:08:16.109743Z","caller":"traceutil/trace.go:171","msg":"trace[484243541] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2724; }","duration":"296.423915ms","start":"2026-05-08T22:08:15.813304Z","end":"2026-05-08T22:08:16.109727Z","steps":["trace[484243541] 'range keys from in-memory index tree'  (duration: 296.134988ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T22:08:16.110424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.014445ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14933265703580280489 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:2717 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-08T22:08:16.110531Z","caller":"traceutil/trace.go:171","msg":"trace[25566442] transaction","detail":"{read_only:false; response_revision:2725; number_of_response:1; }","duration":"204.75577ms","start":"2026-05-08T22:08:15.905736Z","end":"2026-05-08T22:08:16.110492Z","steps":["trace[25566442] 'process raft request'  (duration: 12.627046ms)","trace[25566442] 'compare'  (duration: 191.177933ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-08T22:12:10.29155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.288326ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:12970"}
{"level":"info","ts":"2026-05-08T22:12:10.291635Z","caller":"traceutil/trace.go:171","msg":"trace[90379831] range","detail":"{range_begin:/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4688; }","duration":"127.462602ms","start":"2026-05-08T22:12:10.164148Z","end":"2026-05-08T22:12:10.291611Z","steps":["trace[90379831] 'range keys from in-memory index tree'  (duration: 127.13805ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T22:12:10.292047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.921115ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14933265703580285175 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/monitoring/kube-prometheus-stack-grafana-7fbf4654b9-lzk8k.18adb6b83513eaa8\" mod_revision:0 > success:<request_put:<key:\"/registry/events/monitoring/kube-prometheus-stack-grafana-7fbf4654b9-lzk8k.18adb6b83513eaa8\" value_size:774 lease:5709893666725508207 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-05-08T22:12:10.292172Z","caller":"traceutil/trace.go:171","msg":"trace[2023105447] linearizableReadLoop","detail":"{readStateIndex:4867; appliedIndex:4866; }","duration":"101.676714ms","start":"2026-05-08T22:12:10.190479Z","end":"2026-05-08T22:12:10.292156Z","steps":["trace[2023105447] 'read index received'  (duration: 46.092µs)","trace[2023105447] 'applied index is now lower than readState.Index'  (duration: 101.628762ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T22:12:10.292308Z","caller":"traceutil/trace.go:171","msg":"trace[1092529756] transaction","detail":"{read_only:false; response_revision:4689; number_of_response:1; }","duration":"125.997695ms","start":"2026-05-08T22:12:10.166297Z","end":"2026-05-08T22:12:10.292295Z","steps":["trace[1092529756] 'compare'  (duration: 118.319831ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T22:12:10.292659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.137112ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"warn","ts":"2026-05-08T22:12:10.292696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.388183ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"}
{"level":"info","ts":"2026-05-08T22:12:10.292744Z","caller":"traceutil/trace.go:171","msg":"trace[1414272696] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:4689; }","duration":"102.29871ms","start":"2026-05-08T22:12:10.190426Z","end":"2026-05-08T22:12:10.292725Z","steps":["trace[1414272696] 'agreement among raft nodes before linearized reading'  (duration: 102.060279ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T22:12:10.292786Z","caller":"traceutil/trace.go:171","msg":"trace[1753483599] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4689; }","duration":"100.515678ms","start":"2026-05-08T22:12:10.192246Z","end":"2026-05-08T22:12:10.292761Z","steps":["trace[1753483599] 'agreement among raft nodes before linearized reading'  (duration: 100.238986ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T22:12:10.483486Z","caller":"traceutil/trace.go:171","msg":"trace[1460202527] transaction","detail":"{read_only:false; response_revision:4690; number_of_response:1; }","duration":"179.168964ms","start":"2026-05-08T22:12:10.304278Z","end":"2026-05-08T22:12:10.483447Z","steps":["trace[1460202527] 'process raft request'  (duration: 127.462322ms)","trace[1460202527] 'compare'  (duration: 51.369627ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T22:12:10.484366Z","caller":"traceutil/trace.go:171","msg":"trace[1900033090] transaction","detail":"{read_only:false; response_revision:4691; number_of_response:1; }","duration":"168.42754ms","start":"2026-05-08T22:12:10.31592Z","end":"2026-05-08T22:12:10.484348Z","steps":["trace[1900033090] 'process raft request'  (duration: 167.395709ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T22:12:10.484501Z","caller":"traceutil/trace.go:171","msg":"trace[722274778] transaction","detail":"{read_only:false; response_revision:4692; number_of_response:1; }","duration":"160.183134ms","start":"2026-05-08T22:12:10.324289Z","end":"2026-05-08T22:12:10.484472Z","steps":["trace[722274778] 'process raft request'  (duration: 159.976476ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T22:12:10.943133Z","caller":"traceutil/trace.go:171","msg":"trace[241958117] transaction","detail":"{read_only:false; response_revision:4702; number_of_response:1; }","duration":"199.342251ms","start":"2026-05-08T22:12:10.743762Z","end":"2026-05-08T22:12:10.943104Z","steps":["trace[241958117] 'process raft request'  (duration: 199.259487ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T22:12:10.94343Z","caller":"traceutil/trace.go:171","msg":"trace[1494162757] transaction","detail":"{read_only:false; response_revision:4701; number_of_response:1; }","duration":"253.168876ms","start":"2026-05-08T22:12:10.690213Z","end":"2026-05-08T22:12:10.943382Z","steps":["trace[1494162757] 'process raft request'  (duration: 177.7741ms)","trace[1494162757] 'compare'  (duration: 74.879226ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T22:12:11.113935Z","caller":"traceutil/trace.go:171","msg":"trace[474955460] linearizableReadLoop","detail":"{readStateIndex:4884; appliedIndex:4881; }","duration":"122.633749ms","start":"2026-05-08T22:12:10.991283Z","end":"2026-05-08T22:12:11.113917Z","steps":["trace[474955460] 'read index received'  (duration: 94.234016ms)","trace[474955460] 'applied index is now lower than readState.Index'  (duration: 28.398963ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-08T22:12:11.114198Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.89034ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:130136"}
{"level":"info","ts":"2026-05-08T22:12:11.114244Z","caller":"traceutil/trace.go:171","msg":"trace[703331990] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:4707; }","duration":"122.977823ms","start":"2026-05-08T22:12:10.99125Z","end":"2026-05-08T22:12:11.114227Z","steps":["trace[703331990] 'agreement among raft nodes before linearized reading'  (duration: 122.748294ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T22:12:11.114232Z","caller":"traceutil/trace.go:171","msg":"trace[948892003] transaction","detail":"{read_only:false; response_revision:4706; number_of_response:1; }","duration":"123.65749ms","start":"2026-05-08T22:12:10.990531Z","end":"2026-05-08T22:12:11.114188Z","steps":["trace[948892003] 'process raft request'  (duration: 123.313686ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T22:12:11.114421Z","caller":"traceutil/trace.go:171","msg":"trace[1778369930] transaction","detail":"{read_only:false; response_revision:4704; number_of_response:1; }","duration":"124.595667ms","start":"2026-05-08T22:12:10.98978Z","end":"2026-05-08T22:12:11.114376Z","steps":["trace[1778369930] 'process raft request'  (duration: 95.657412ms)","trace[1778369930] 'compare'  (duration: 28.225427ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T22:12:11.11487Z","caller":"traceutil/trace.go:171","msg":"trace[1496005635] transaction","detail":"{read_only:false; response_revision:4705; number_of_response:1; }","duration":"125.047085ms","start":"2026-05-08T22:12:10.989804Z","end":"2026-05-08T22:12:11.114852Z","steps":["trace[1496005635] 'process raft request'  (duration: 123.999004ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T22:12:23.560758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.044334ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14933265703580285762 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/services/endpoints/openstack/rabbitmq-keystone-nodes\" mod_revision:4704 > success:<request_put:<key:\"/registry/services/endpoints/openstack/rabbitmq-keystone-nodes\" value_size:881 >> failure:<request_range:<key:\"/registry/services/endpoints/openstack/rabbitmq-keystone-nodes\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-08T22:12:23.561137Z","caller":"traceutil/trace.go:171","msg":"trace[1816882999] linearizableReadLoop","detail":"{readStateIndex:5117; appliedIndex:5114; }","duration":"133.884606ms","start":"2026-05-08T22:12:23.427234Z","end":"2026-05-08T22:12:23.561119Z","steps":["trace[1816882999] 'read index received'  (duration: 22.324181ms)","trace[1816882999] 'applied index is now lower than readState.Index'  (duration: 111.559155ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T22:12:23.561149Z","caller":"traceutil/trace.go:171","msg":"trace[1510780944] transaction","detail":"{read_only:false; response_revision:4931; number_of_response:1; }","duration":"200.730265ms","start":"2026-05-08T22:12:23.360292Z","end":"2026-05-08T22:12:23.561022Z","steps":["trace[1510780944] 'process raft request'  (duration: 89.336047ms)","trace[1510780944] 'compare'  (duration: 110.913989ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-08T22:12:23.561664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.03879ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"}
{"level":"info","ts":"2026-05-08T22:12:23.561757Z","caller":"traceutil/trace.go:171","msg":"trace[889474364] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4933; }","duration":"104.129084ms","start":"2026-05-08T22:12:23.457592Z","end":"2026-05-08T22:12:23.561721Z","steps":["trace[889474364] 'agreement among raft nodes before linearized reading'  (duration: 103.984458ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T22:12:23.561733Z","caller":"traceutil/trace.go:171","msg":"trace[606169508] transaction","detail":"{read_only:false; response_revision:4933; number_of_response:1; }","duration":"201.315109ms","start":"2026-05-08T22:12:23.360371Z","end":"2026-05-08T22:12:23.561686Z","steps":["trace[606169508] 'process raft request'  (duration: 200.676393ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T22:12:23.561776Z","caller":"traceutil/trace.go:171","msg":"trace[1763559911] transaction","detail":"{read_only:false; response_revision:4932; number_of_response:1; }","duration":"201.397313ms","start":"2026-05-08T22:12:23.36034Z","end":"2026-05-08T22:12:23.561737Z","steps":["trace[1763559911] 'process raft request'  (duration: 200.58875ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T22:12:23.561852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.841383ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"}
{"level":"info","ts":"2026-05-08T22:12:23.561903Z","caller":"traceutil/trace.go:171","msg":"trace[273614336] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4933; }","duration":"102.914696ms","start":"2026-05-08T22:12:23.458977Z","end":"2026-05-08T22:12:23.561892Z","steps":["trace[273614336] 'agreement among raft nodes before linearized reading'  (duration: 102.721388ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T22:12:23.561878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.608205ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"}
{"level":"info","ts":"2026-05-08T22:12:23.562058Z","caller":"traceutil/trace.go:171","msg":"trace[2032851090] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4933; }","duration":"134.791172ms","start":"2026-05-08T22:12:23.427188Z","end":"2026-05-08T22:12:23.561979Z","steps":["trace[2032851090] 'agreement among raft nodes before linearized reading'  (duration: 134.390086ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T22:13:17.040635Z","caller":"traceutil/trace.go:171","msg":"trace[305097086] transaction","detail":"{read_only:false; response_revision:5369; number_of_response:1; }","duration":"313.282403ms","start":"2026-05-08T22:13:16.727324Z","end":"2026-05-08T22:13:17.040606Z","steps":["trace[305097086] 'process raft request'  (duration: 313.146497ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T22:13:17.040827Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T22:13:16.727296Z","time spent":"313.424529ms","remote":"127.0.0.1:50996","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5468,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/jobs/openstack/keystone-db-init\" mod_revision:5304 > success:<request_put:<key:\"/registry/jobs/openstack/keystone-db-init\" value_size:5419 >> failure:<request_range:<key:\"/registry/jobs/openstack/keystone-db-init\" > >"}
{"level":"info","ts":"2026-05-08T22:13:17.049388Z","caller":"traceutil/trace.go:171","msg":"trace[1930590495] transaction","detail":"{read_only:false; response_revision:5370; number_of_response:1; }","duration":"281.425466ms","start":"2026-05-08T22:13:16.76793Z","end":"2026-05-08T22:13:17.049356Z","steps":["trace[1930590495] 'process raft request'  (duration: 281.249278ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T22:13:17.433294Z","caller":"traceutil/trace.go:171","msg":"trace[963905746] linearizableReadLoop","detail":"{readStateIndex:5567; appliedIndex:5566; }","duration":"132.473691ms","start":"2026-05-08T22:13:17.300791Z","end":"2026-05-08T22:13:17.433265Z","steps":["trace[963905746] 'read index received'  (duration: 131.258379ms)","trace[963905746] 'applied index is now lower than readState.Index'  (duration: 1.213782ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T22:13:17.433309Z","caller":"traceutil/trace.go:171","msg":"trace[296973110] transaction","detail":"{read_only:false; response_revision:5371; number_of_response:1; }","duration":"138.005091ms","start":"2026-05-08T22:13:17.295257Z","end":"2026-05-08T22:13:17.433262Z","steps":["trace[296973110] 'process raft request'  (duration: 136.714956ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T22:13:17.43937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.553485ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-05-08T22:13:17.43942Z","caller":"traceutil/trace.go:171","msg":"trace[420158453] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5371; }","duration":"138.665449ms","start":"2026-05-08T22:13:17.300743Z","end":"2026-05-08T22:13:17.439408Z","steps":["trace[420158453] 'agreement among raft nodes before linearized reading'  (duration: 132.703901ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T22:13:18.61435Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14933265703580286901,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-05-08T22:13:19.11466Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14933265703580286901,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-05-08T22:13:19.615283Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14933265703580286901,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-05-08T22:13:20.116043Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14933265703580286901,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-05-08T22:13:20.566053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000130855s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-05-08T22:13:20.566178Z","caller":"traceutil/trace.go:171","msg":"trace[810537611] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000360205s","start":"2026-05-08T22:13:18.565791Z","end":"2026-05-08T22:13:20.566151Z","steps":["trace[810537611] 'agreement among raft nodes before linearized reading'  (duration: 2.000170547s)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T22:13:20.56624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T22:13:18.565771Z","time spent":"2.00045568s","remote":"127.0.0.1:50702","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-05-08T22:13:20.616928Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14933265703580286901,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-05-08T22:13:21.117112Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14933265703580286901,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-05-08T22:13:21.337031Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"3.285592749s","expected-duration":"1s"}
{"level":"info","ts":"2026-05-08T22:13:21.338433Z","caller":"traceutil/trace.go:171","msg":"trace[1475612711] transaction","detail":"{read_only:false; response_revision:5375; number_of_response:1; }","duration":"3.287140945s","start":"2026-05-08T22:13:18.051264Z","end":"2026-05-08T22:13:21.338405Z","steps":["trace[1475612711] 'process raft request'  (duration: 3.286156383s)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T22:13:21.338584Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T22:13:18.051243Z","time spent":"3.28725262s","remote":"127.0.0.1:50996","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5468,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/jobs/openstack/keystone-db-init\" mod_revision:5369 > success:<request_put:<key:\"/registry/jobs/openstack/keystone-db-init\" value_size:5419 >> failure:<request_range:<key:\"/registry/jobs/openstack/keystone-db-init\" > >"}
{"level":"info","ts":"2026-05-08T22:13:21.344046Z","caller":"traceutil/trace.go:171","msg":"trace[1349012085] linearizableReadLoop","detail":"{readStateIndex:5576; appliedIndex:5571; }","duration":"3.230304784s","start":"2026-05-08T22:13:18.113719Z","end":"2026-05-08T22:13:21.344024Z","steps":["trace[1349012085] 'read index received'  (duration: 3.223672056s)","trace[1349012085] 'applied index is now lower than readState.Index'  (duration: 6.631788ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T22:13:21.344461Z","caller":"traceutil/trace.go:171","msg":"trace[1977957168] transaction","detail":"{read_only:false; response_revision:5376; number_of_response:1; }","duration":"3.186620513s","start":"2026-05-08T22:13:18.157829Z","end":"2026-05-08T22:13:21.344449Z","steps":["trace[1977957168] 'process raft request'  (duration: 3.185949134s)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T22:13:21.344682Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T22:13:18.157808Z","time spent":"3.186681044s","remote":"127.0.0.1:51024","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:5366 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:457 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"info","ts":"2026-05-08T22:13:21.344911Z","caller":"traceutil/trace.go:171","msg":"trace[1083022600] transaction","detail":"{read_only:false; response_revision:5377; number_of_response:1; }","duration":"2.290676827s","start":"2026-05-08T22:13:19.054224Z","end":"2026-05-08T22:13:21.344901Z","steps":["trace[1083022600] 'process raft request'  (duration: 2.289670244s)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T22:13:21.344957Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T22:13:19.054186Z","time spent":"2.290747829s","remote":"127.0.0.1:51024","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:5370 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:477 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"info","ts":"2026-05-08T22:13:21.345364Z","caller":"traceutil/trace.go:171","msg":"trace[2049978561] transaction","detail":"{read_only:false; response_revision:5379; number_of_response:1; }","duration":"1.90183889s","start":"2026-05-08T22:13:19.443511Z","end":"2026-05-08T22:13:21.34535Z","steps":["trace[2049978561] 'process raft request'  (duration: 1.900485001s)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T22:13:21.34545Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T22:13:19.443499Z","time spent":"1.901915223s","remote":"127.0.0.1:51024","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:5372 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-05-08T22:13:21.345552Z","caller":"traceutil/trace.go:171","msg":"trace[764134247] transaction","detail":"{read_only:false; response_revision:5378; number_of_response:1; }","duration":"1.905839355s","start":"2026-05-08T22:13:19.439704Z","end":"2026-05-08T22:13:21.345543Z","steps":["trace[764134247] 'process raft request'  (duration: 1.904265166s)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T22:13:21.345534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.21864255s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"warn","ts":"2026-05-08T22:13:21.345606Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T22:13:19.439677Z","time spent":"1.905898367s","remote":"127.0.0.1:51024","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:5371 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:464 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"info","ts":"2026-05-08T22:13:21.345612Z","caller":"traceutil/trace.go:171","msg":"trace[587349155] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5379; }","duration":"3.218771036s","start":"2026-05-08T22:13:18.126819Z","end":"2026-05-08T22:13:21.34559Z","steps":["trace[587349155] 'agreement among raft nodes before linearized reading'  (duration: 3.218537296s)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T22:13:21.345659Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T22:13:18.126795Z","time spent":"3.218852969s","remote":"127.0.0.1:51024","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-05-08T22:13:21.3458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.950388691s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-fernet-setup\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-08T22:13:21.345829Z","caller":"traceutil/trace.go:171","msg":"trace[865643298] range","detail":"{range_begin:/registry/jobs/openstack/keystone-fernet-setup; range_end:; response_count:0; response_revision:5379; }","duration":"2.950439874s","start":"2026-05-08T22:13:18.395381Z","end":"2026-05-08T22:13:21.345821Z","steps":["trace[865643298] 'agreement among raft nodes before linearized reading'  (duration: 2.950388881s)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T22:13:21.345823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.511186601s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/sshkeys/\" range_end:\"/registry/secretgen.k14s.io/sshkeys0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-05-08T22:13:21.345852Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T22:13:18.395368Z","time spent":"2.950478166s","remote":"127.0.0.1:50996","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/openstack/keystone-fernet-setup\" "}
{"level":"info","ts":"2026-05-08T22:13:21.34586Z","caller":"traceutil/trace.go:171","msg":"trace[1556341255] range","detail":"{range_begin:/registry/secretgen.k14s.io/sshkeys/; range_end:/registry/secretgen.k14s.io/sshkeys0; response_count:0; response_revision:5379; }","duration":"2.511279775s","start":"2026-05-08T22:13:18.834568Z","end":"2026-05-08T22:13:21.345847Z","steps":["trace[1556341255] 'agreement among raft nodes before linearized reading'  (duration: 2.511202051s)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T22:13:21.345891Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T22:13:18.83455Z","time spent":"2.511331156s","remote":"127.0.0.1:39818","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":28,"request content":"key:\"/registry/secretgen.k14s.io/sshkeys/\" range_end:\"/registry/secretgen.k14s.io/sshkeys0\" count_only:true "}
{"level":"warn","ts":"2026-05-08T22:13:21.345988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.071431435s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"info","ts":"2026-05-08T22:13:21.346031Z","caller":"traceutil/trace.go:171","msg":"trace[1868400947] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5379; }","duration":"3.071512848s","start":"2026-05-08T22:13:18.274508Z","end":"2026-05-08T22:13:21.346021Z","steps":["trace[1868400947] 'agreement among raft nodes before linearized reading'  (duration: 3.071405364s)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T22:13:21.346059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.938048568s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"warn","ts":"2026-05-08T22:13:21.346059Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T22:13:18.274476Z","time spent":"3.071576761s","remote":"127.0.0.1:51024","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-05-08T22:13:21.34608Z","caller":"traceutil/trace.go:171","msg":"trace[783376592] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5379; }","duration":"2.93810716s","start":"2026-05-08T22:13:18.407967Z","end":"2026-05-08T22:13:21.346074Z","steps":["trace[783376592] 'agreement among raft nodes before linearized reading'  (duration: 2.938041877s)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T22:13:21.346097Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T22:13:18.407255Z","time spent":"2.938839271s","remote":"127.0.0.1:51024","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-05-08T22:13:21.346106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.232393686s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-05-08T22:13:21.346214Z","caller":"traceutil/trace.go:171","msg":"trace[2116532851] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5379; }","duration":"3.232544812s","start":"2026-05-08T22:13:18.113657Z","end":"2026-05-08T22:13:21.346202Z","steps":["trace[2116532851] 'agreement among raft nodes before linearized reading'  (duration: 3.232379155s)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T22:13:21.345995Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.616559034s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"warn","ts":"2026-05-08T22:13:21.346336Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T22:13:18.113629Z","time spent":"3.232695788s","remote":"127.0.0.1:51024","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"info","ts":"2026-05-08T22:13:21.346346Z","caller":"traceutil/trace.go:171","msg":"trace[535115457] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:5379; }","duration":"2.616906189s","start":"2026-05-08T22:13:18.729429Z","end":"2026-05-08T22:13:21.346335Z","steps":["trace[535115457] 'agreement among raft nodes before linearized reading'  (duration: 2.616520932s)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T22:13:21.346232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.210581ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12214"}
{"level":"warn","ts":"2026-05-08T22:13:21.346401Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T22:13:18.729365Z","time spent":"2.617007132s","remote":"127.0.0.1:51066","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":38,"response size":30,"request content":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true "}
{"level":"info","ts":"2026-05-08T22:13:21.346422Z","caller":"traceutil/trace.go:171","msg":"trace[1673656373] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5379; }","duration":"280.463512ms","start":"2026-05-08T22:13:21.065949Z","end":"2026-05-08T22:13:21.346412Z","steps":["trace[1673656373] 'agreement among raft nodes before linearized reading'  (duration: 280.229992ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T22:13:21.346154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"779.221098ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-05-08T22:13:21.345892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.950515677s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-db-sync\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-08T22:13:21.346544Z","caller":"traceutil/trace.go:171","msg":"trace[1479789831] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5379; }","duration":"779.643256ms","start":"2026-05-08T22:13:20.566894Z","end":"2026-05-08T22:13:21.346537Z","steps":["trace[1479789831] 'agreement among raft nodes before linearized reading'  (duration: 779.230339ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T22:13:21.346557Z","caller":"traceutil/trace.go:171","msg":"trace[1882882453] range","detail":"{range_begin:/registry/jobs/openstack/keystone-db-sync; range_end:; response_count:0; response_revision:5379; }","duration":"2.951218608s","start":"2026-05-08T22:13:18.395327Z","end":"2026-05-08T22:13:21.346545Z","steps":["trace[1882882453] 'agreement among raft nodes before linearized reading'  (duration: 2.950532398s)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T22:13:21.346604Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T22:13:18.395305Z","time spent":"2.951288711s","remote":"127.0.0.1:50996","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/openstack/keystone-db-sync\" "}
{"level":"warn","ts":"2026-05-08T22:13:21.346285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"432.362996ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/servicemonitors/\" range_end:\"/registry/monitoring.coreos.com/servicemonitors0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-05-08T22:13:21.346654Z","caller":"traceutil/trace.go:171","msg":"trace[247531508] range","detail":"{range_begin:/registry/monitoring.coreos.com/servicemonitors/; range_end:/registry/monitoring.coreos.com/servicemonitors0; response_count:0; response_revision:5379; }","duration":"432.784604ms","start":"2026-05-08T22:13:20.91386Z","end":"2026-05-08T22:13:21.346644Z","steps":["trace[247531508] 'agreement among raft nodes before linearized reading'  (duration: 432.343175ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T22:13:21.346569Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T22:13:20.566874Z","time spent":"779.686969ms","remote":"127.0.0.1:50714","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-05-08T22:13:21.346686Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T22:13:20.913831Z","time spent":"432.843936ms","remote":"127.0.0.1:50698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":21,"response size":30,"request content":"key:\"/registry/monitoring.coreos.com/servicemonitors/\" range_end:\"/registry/monitoring.coreos.com/servicemonitors0\" count_only:true "}
{"level":"warn","ts":"2026-05-08T22:13:21.346179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.897097635s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-05-08T22:13:21.346784Z","caller":"traceutil/trace.go:171","msg":"trace[1562264322] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5379; }","duration":"1.897730802s","start":"2026-05-08T22:13:19.449047Z","end":"2026-05-08T22:13:21.346778Z","steps":["trace[1562264322] 'agreement among raft nodes before linearized reading'  (duration: 1.897087554s)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T22:13:21.346801Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T22:13:19.449036Z","time spent":"1.897760284s","remote":"127.0.0.1:51024","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-05-08T22:13:59.044334Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2953}
{"level":"info","ts":"2026-05-08T22:13:59.126684Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2953,"took":"79.416228ms","hash":3902878269,"current-db-size-bytes":53350400,"current-db-size":"53 MB","current-db-size-in-use-bytes":29544448,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-05-08T22:13:59.12677Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3902878269,"revision":2953,"compact-revision":-1}
{"level":"info","ts":"2026-05-08T22:16:12.459377Z","caller":"traceutil/trace.go:171","msg":"trace[1761592501] linearizableReadLoop","detail":"{readStateIndex:6806; appliedIndex:6804; }","duration":"123.283258ms","start":"2026-05-08T22:16:12.336066Z","end":"2026-05-08T22:16:12.459349Z","steps":["trace[1761592501] 'read index received'  (duration: 72.736614ms)","trace[1761592501] 'applied index is now lower than readState.Index'  (duration: 50.544644ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T22:16:12.459484Z","caller":"traceutil/trace.go:171","msg":"trace[1611804230] transaction","detail":"{read_only:false; response_revision:6565; number_of_response:1; }","duration":"125.196398ms","start":"2026-05-08T22:16:12.334278Z","end":"2026-05-08T22:16:12.459475Z","steps":["trace[1611804230] 'process raft request'  (duration: 125.008039ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T22:16:12.459705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.615573ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-05-08T22:16:12.45977Z","caller":"traceutil/trace.go:171","msg":"trace[629045944] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:6565; }","duration":"123.719969ms","start":"2026-05-08T22:16:12.336032Z","end":"2026-05-08T22:16:12.459752Z","steps":["trace[629045944] 'agreement among raft nodes before linearized reading'  (duration: 123.53212ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-08T22:16:12.459901Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.802424ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"}
{"level":"info","ts":"2026-05-08T22:16:12.459999Z","caller":"traceutil/trace.go:171","msg":"trace[149491034] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:6565; }","duration":"104.95636ms","start":"2026-05-08T22:16:12.355022Z","end":"2026-05-08T22:16:12.459978Z","steps":["trace[149491034] 'agreement among raft nodes before linearized reading'  (duration: 104.705188ms)"],"step_count":1}
{"level":"info","ts":"2026-05-08T22:16:12.459399Z","caller":"traceutil/trace.go:171","msg":"trace[595864221] transaction","detail":"{read_only:false; response_revision:6564; number_of_response:1; }","duration":"126.021717ms","start":"2026-05-08T22:16:12.333335Z","end":"2026-05-08T22:16:12.459357Z","steps":["trace[595864221] 'process raft request'  (duration: 75.453223ms)","trace[595864221] 'compare'  (duration: 50.342834ms)"],"step_count":2}
{"level":"info","ts":"2026-05-08T22:18:59.05004Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5680}
{"level":"info","ts":"2026-05-08T22:18:59.15137Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5680,"took":"99.616043ms","hash":3571357244,"current-db-size-bytes":53350400,"current-db-size":"53 MB","current-db-size-in-use-bytes":18370560,"current-db-size-in-use":"18 MB"}
{"level":"info","ts":"2026-05-08T22:18:59.151535Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3571357244,"revision":5680,"compact-revision":2953}