{"level":"warn","ts":"2026-06-10T08:13:36.142231Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-10T08:13:36.142337Z","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-06-10T08:13:36.142409Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-10T08:13:36.142419Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.3:2380"]} {"level":"info","ts":"2026-06-10T08:13:36.142439Z","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-06-10T08:13:36.143083Z","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-06-10T08:13:36.143168Z","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":16,"max-cpu-available":16,"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-06-10T08:13:36.145823Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.453976ms"} {"level":"info","ts":"2026-06-10T08:13:36.150694Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"597401b06ce1cf3d","cluster-id":"dfc54657ad8a2432"} {"level":"info","ts":"2026-06-10T08:13:36.150759Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d switched to configuration voters=()"} {"level":"info","ts":"2026-06-10T08:13:36.150781Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d became follower at term 0"} {"level":"info","ts":"2026-06-10T08:13:36.150796Z","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-06-10T08:13:36.150806Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d became follower at term 1"} {"level":"info","ts":"2026-06-10T08:13:36.150861Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d switched to configuration voters=(6445778823926632253)"} {"level":"warn","ts":"2026-06-10T08:13:36.156125Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-10T08:13:36.157697Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-10T08:13:36.159523Z","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-06-10T08:13:36.161953Z","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-06-10T08:13:36.162196Z","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-06-10T08:13:36.162335Z","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-06-10T08:13:36.162428Z","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-06-10T08:13:36.162464Z","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-06-10T08:13:36.163337Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d switched to configuration voters=(6445778823926632253)"} {"level":"info","ts":"2026-06-10T08:13:36.163804Z","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-06-10T08:13:36.169269Z","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-06-10T08:13:36.169462Z","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-06-10T08:13:36.169498Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-10T08:13:36.169526Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.3:2380"} {"level":"info","ts":"2026-06-10T08:13:36.169575Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.3:2380"} {"level":"info","ts":"2026-06-10T08:13:36.652041Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d is starting a new election at term 1"} {"level":"info","ts":"2026-06-10T08:13:36.652122Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d became pre-candidate at term 1"} {"level":"info","ts":"2026-06-10T08:13:36.652152Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d received MsgPreVoteResp from 597401b06ce1cf3d at term 1"} {"level":"info","ts":"2026-06-10T08:13:36.65218Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d became candidate at term 2"} {"level":"info","ts":"2026-06-10T08:13:36.652197Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d received MsgVoteResp from 597401b06ce1cf3d at term 2"} {"level":"info","ts":"2026-06-10T08:13:36.652219Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d became leader at term 2"} {"level":"info","ts":"2026-06-10T08:13:36.652237Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 597401b06ce1cf3d elected leader 597401b06ce1cf3d at term 2"} {"level":"info","ts":"2026-06-10T08:13:36.653353Z","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-06-10T08:13:36.653568Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-10T08:13:36.653695Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-10T08:13:36.653794Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-10T08:13:36.654828Z","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-06-10T08:13:36.654967Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-10T08:13:36.655009Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-10T08:13:36.656765Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-10T08:13:36.656816Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-10T08:13:36.657031Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.3:2379"} {"level":"info","ts":"2026-06-10T08:13:36.658018Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-10T08:13:54.864449Z","caller":"traceutil/trace.go:171","msg":"trace[1456379568] transaction","detail":"{read_only:false; response_revision:393; number_of_response:1; }","duration":"204.173596ms","start":"2026-06-10T08:13:54.660253Z","end":"2026-06-10T08:13:54.864426Z","steps":["trace[1456379568] 'process raft request' (duration: 204.013123ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:14:00.268595Z","caller":"traceutil/trace.go:171","msg":"trace[1933771783] transaction","detail":"{read_only:false; response_revision:406; number_of_response:1; }","duration":"105.942352ms","start":"2026-06-10T08:14:00.162625Z","end":"2026-06-10T08:14:00.268568Z","steps":["trace[1933771783] 'process raft request' (duration: 105.734708ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:14:30.016094Z","caller":"traceutil/trace.go:171","msg":"trace[1825605116] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"161.37785ms","start":"2026-06-10T08:14:29.854624Z","end":"2026-06-10T08:14:30.016002Z","steps":["trace[1825605116] 'process raft request' (duration: 159.454264ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:14:30.553181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"445.808989ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:40"} {"level":"info","ts":"2026-06-10T08:14:30.55348Z","caller":"traceutil/trace.go:171","msg":"trace[1812831107] linearizableReadLoop","detail":"{readStateIndex:655; appliedIndex:653; }","duration":"397.454297ms","start":"2026-06-10T08:14:30.156009Z","end":"2026-06-10T08:14:30.553464Z","steps":["trace[1812831107] 'read index received' (duration: 62.041µs)","trace[1812831107] 'applied index is now lower than readState.Index' (duration: 397.391056ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:14:30.553517Z","caller":"traceutil/trace.go:171","msg":"trace[1242647821] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"474.000047ms","start":"2026-06-10T08:14:30.079482Z","end":"2026-06-10T08:14:30.553482Z","steps":["trace[1242647821] 'process raft request' (duration: 473.860465ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:14:30.55364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"397.61913ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-10T08:14:30.553669Z","caller":"traceutil/trace.go:171","msg":"trace[437100167] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:631; }","duration":"397.703461ms","start":"2026-06-10T08:14:30.155957Z","end":"2026-06-10T08:14:30.553661Z","steps":["trace[437100167] 'agreement among raft nodes before linearized reading' (duration: 397.593319ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:14:30.553693Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:14:30.155935Z","time spent":"397.751642ms","remote":"127.0.0.1:54942","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-06-10T08:14:30.553707Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:14:30.017816Z","time spent":"535.875868ms","remote":"127.0.0.1:54752","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-06-10T08:14:30.554311Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:14:30.079459Z","time spent":"474.133509ms","remote":"127.0.0.1:55172","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-10T08:14:30.554495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.333152ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-06-10T08:14:30.554477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.348159ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T08:14:30.554635Z","caller":"traceutil/trace.go:171","msg":"trace[692138188] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:631; }","duration":"273.644713ms","start":"2026-06-10T08:14:30.280938Z","end":"2026-06-10T08:14:30.554583Z","steps":["trace[692138188] 'agreement among raft nodes before linearized reading' (duration: 273.339808ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:14:30.554551Z","caller":"traceutil/trace.go:171","msg":"trace[1848117413] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:631; }","duration":"115.443124ms","start":"2026-06-10T08:14:30.439095Z","end":"2026-06-10T08:14:30.554538Z","steps":["trace[1848117413] 'agreement among raft nodes before linearized reading' (duration: 115.252471ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:14:30.671099Z","caller":"traceutil/trace.go:171","msg":"trace[482534545] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"111.5819ms","start":"2026-06-10T08:14:30.559483Z","end":"2026-06-10T08:14:30.671065Z","steps":["trace[482534545] 'process raft request' (duration: 110.999409ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:14:30.671416Z","caller":"traceutil/trace.go:171","msg":"trace[358209843] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"109.888696ms","start":"2026-06-10T08:14:30.561514Z","end":"2026-06-10T08:14:30.671403Z","steps":["trace[358209843] 'process raft request' (duration: 109.505969ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:14:30.671486Z","caller":"traceutil/trace.go:171","msg":"trace[1619717812] linearizableReadLoop","detail":"{readStateIndex:659; appliedIndex:655; }","duration":"104.327911ms","start":"2026-06-10T08:14:30.567116Z","end":"2026-06-10T08:14:30.671444Z","steps":["trace[1619717812] 'read index received' (duration: 77.133693ms)","trace[1619717812] 'applied index is now lower than readState.Index' (duration: 27.192448ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:14:30.671774Z","caller":"traceutil/trace.go:171","msg":"trace[1143444108] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"109.800375ms","start":"2026-06-10T08:14:30.561793Z","end":"2026-06-10T08:14:30.671594Z","steps":["trace[1143444108] 'process raft request' (duration: 109.501389ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:14:30.671814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.657748ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T08:14:30.671947Z","caller":"traceutil/trace.go:171","msg":"trace[372706899] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:635; }","duration":"104.835771ms","start":"2026-06-10T08:14:30.567077Z","end":"2026-06-10T08:14:30.671912Z","steps":["trace[372706899] 'agreement among raft nodes before linearized reading' (duration: 104.588736ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:14:45.88709Z","caller":"traceutil/trace.go:171","msg":"trace[449298802] linearizableReadLoop","detail":"{readStateIndex:825; appliedIndex:824; }","duration":"168.159149ms","start":"2026-06-10T08:14:45.718898Z","end":"2026-06-10T08:14:45.887057Z","steps":["trace[449298802] 'read index received' (duration: 167.926554ms)","trace[449298802] 'applied index is now lower than readState.Index' (duration: 231.425µs)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:14:45.887245Z","caller":"traceutil/trace.go:171","msg":"trace[315062886] transaction","detail":"{read_only:false; response_revision:795; number_of_response:1; }","duration":"172.472242ms","start":"2026-06-10T08:14:45.714763Z","end":"2026-06-10T08:14:45.887235Z","steps":["trace[315062886] 'process raft request' (duration: 172.079343ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:14:45.887589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.653758ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T08:14:45.887682Z","caller":"traceutil/trace.go:171","msg":"trace[1426952931] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:795; }","duration":"168.791402ms","start":"2026-06-10T08:14:45.718872Z","end":"2026-06-10T08:14:45.887664Z","steps":["trace[1426952931] 'agreement among raft nodes before linearized reading' (duration: 168.590778ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:14:45.887596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.763792ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-10T08:14:45.887827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.871142ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T08:14:45.887884Z","caller":"traceutil/trace.go:171","msg":"trace[1830763365] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:795; }","duration":"168.025117ms","start":"2026-06-10T08:14:45.719777Z","end":"2026-06-10T08:14:45.887802Z","steps":["trace[1830763365] 'agreement among raft nodes before linearized reading' (duration: 167.739612ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:14:45.888002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.568891ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T08:14:45.888007Z","caller":"traceutil/trace.go:171","msg":"trace[792669339] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:795; }","duration":"169.108817ms","start":"2026-06-10T08:14:45.718864Z","end":"2026-06-10T08:14:45.887972Z","steps":["trace[792669339] 'agreement among raft nodes before linearized reading' (duration: 168.792672ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:14:45.888043Z","caller":"traceutil/trace.go:171","msg":"trace[388921188] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:795; }","duration":"121.653512ms","start":"2026-06-10T08:14:45.766381Z","end":"2026-06-10T08:14:45.888034Z","steps":["trace[388921188] 'agreement among raft nodes before linearized reading' (duration: 121.589181ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:14:45.88819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.741804ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T08:14:45.888291Z","caller":"traceutil/trace.go:171","msg":"trace[338083381] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:795; }","duration":"121.871347ms","start":"2026-06-10T08:14:45.766386Z","end":"2026-06-10T08:14:45.888257Z","steps":["trace[338083381] 'agreement among raft nodes before linearized reading' (duration: 121.737324ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:15:14.236833Z","caller":"traceutil/trace.go:171","msg":"trace[1595383233] transaction","detail":"{read_only:false; response_revision:1188; number_of_response:1; }","duration":"130.801135ms","start":"2026-06-10T08:15:14.105996Z","end":"2026-06-10T08:15:14.236797Z","steps":["trace[1595383233] 'process raft request' (duration: 130.587601ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:16:03.484088Z","caller":"traceutil/trace.go:171","msg":"trace[608696009] linearizableReadLoop","detail":"{readStateIndex:1940; appliedIndex:1939; }","duration":"344.302916ms","start":"2026-06-10T08:16:03.139744Z","end":"2026-06-10T08:16:03.484047Z","steps":["trace[608696009] 'read index received' (duration: 268.342645ms)","trace[608696009] 'applied index is now lower than readState.Index' (duration: 75.957971ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:16:03.484193Z","caller":"traceutil/trace.go:171","msg":"trace[1743976810] transaction","detail":"{read_only:false; response_revision:1866; number_of_response:1; }","duration":"351.649264ms","start":"2026-06-10T08:16:03.132484Z","end":"2026-06-10T08:16:03.484133Z","steps":["trace[1743976810] 'process raft request' (duration: 275.617782ms)","trace[1743976810] 'compare' (duration: 75.672166ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T08:16:03.484506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.748105ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-99b04509-5c24-45ac-aec5-efc3bc0414c6\" ","response":"range_response_count:1 size:3625"} {"level":"info","ts":"2026-06-10T08:16:03.484562Z","caller":"traceutil/trace.go:171","msg":"trace[192707953] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-99b04509-5c24-45ac-aec5-efc3bc0414c6; range_end:; response_count:1; response_revision:1866; }","duration":"344.872676ms","start":"2026-06-10T08:16:03.139674Z","end":"2026-06-10T08:16:03.484547Z","steps":["trace[192707953] 'agreement among raft nodes before linearized reading' (duration: 344.53583ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:16:03.484642Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:16:03.139647Z","time spent":"344.983428ms","remote":"127.0.0.1:54868","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3648,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-99b04509-5c24-45ac-aec5-efc3bc0414c6\" "} {"level":"warn","ts":"2026-06-10T08:16:03.484737Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:16:03.132447Z","time spent":"351.856767ms","remote":"127.0.0.1:54942","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T08:16:03.49438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.15644ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-06-10T08:16:03.494384Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.075812ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T08:16:03.494487Z","caller":"traceutil/trace.go:171","msg":"trace[952164303] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1867; }","duration":"329.246632ms","start":"2026-06-10T08:16:03.165186Z","end":"2026-06-10T08:16:03.494433Z","steps":["trace[952164303] 'agreement among raft nodes before linearized reading' (duration: 329.074919ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:16:03.494571Z","caller":"traceutil/trace.go:171","msg":"trace[1746094729] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1867; }","duration":"214.264587ms","start":"2026-06-10T08:16:03.280257Z","end":"2026-06-10T08:16:03.494521Z","steps":["trace[1746094729] 'agreement among raft nodes before linearized reading' (duration: 214.048933ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:16:03.494647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.185206ms","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-06-10T08:16:03.494577Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:16:03.165175Z","time spent":"329.389584ms","remote":"127.0.0.1:54942","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":"warn","ts":"2026-06-10T08:16:03.494668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.444417ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-06-10T08:16:03.494728Z","caller":"traceutil/trace.go:171","msg":"trace[1419220909] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1867; }","duration":"324.324429ms","start":"2026-06-10T08:16:03.170387Z","end":"2026-06-10T08:16:03.494712Z","steps":["trace[1419220909] 'agreement among raft nodes before linearized reading' (duration: 324.035874ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:16:03.494728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.328958ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-06-10T08:16:03.494555Z","caller":"traceutil/trace.go:171","msg":"trace[2004955290] transaction","detail":"{read_only:false; response_revision:1867; number_of_response:1; }","duration":"230.231726ms","start":"2026-06-10T08:16:03.264285Z","end":"2026-06-10T08:16:03.494516Z","steps":["trace[2004955290] 'process raft request' (duration: 229.86402ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:16:03.494774Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:16:03.170363Z","time spent":"324.40485ms","remote":"127.0.0.1:54942","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":"info","ts":"2026-06-10T08:16:03.494809Z","caller":"traceutil/trace.go:171","msg":"trace[350296197] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1867; }","duration":"308.435089ms","start":"2026-06-10T08:16:03.186352Z","end":"2026-06-10T08:16:03.494787Z","steps":["trace[350296197] 'agreement among raft nodes before linearized reading' (duration: 308.157844ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:16:03.494808Z","caller":"traceutil/trace.go:171","msg":"trace[693188387] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1867; }","duration":"319.656421ms","start":"2026-06-10T08:16:03.175104Z","end":"2026-06-10T08:16:03.494761Z","steps":["trace[693188387] 'agreement among raft nodes before linearized reading' (duration: 319.271114ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:16:03.494854Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:16:03.186339Z","time spent":"308.50564ms","remote":"127.0.0.1:54942","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-10T08:16:03.494895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:16:03.17507Z","time spent":"319.808304ms","remote":"127.0.0.1:54942","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-10T08:16:03.952047Z","caller":"traceutil/trace.go:171","msg":"trace[45427261] transaction","detail":"{read_only:false; response_revision:1876; number_of_response:1; }","duration":"320.765223ms","start":"2026-06-10T08:16:03.631243Z","end":"2026-06-10T08:16:03.952008Z","steps":["trace[45427261] 'process raft request' (duration: 306.83411ms)","trace[45427261] 'compare' (duration: 13.517965ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T08:16:03.952273Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:16:03.631136Z","time spent":"321.012857ms","remote":"127.0.0.1:54846","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":893,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T08:16:03.952509Z","caller":"traceutil/trace.go:171","msg":"trace[950991039] transaction","detail":"{read_only:false; response_revision:1877; number_of_response:1; }","duration":"321.132579ms","start":"2026-06-10T08:16:03.631345Z","end":"2026-06-10T08:16:03.952477Z","steps":["trace[950991039] 'process raft request' (duration: 320.570829ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:16:03.952711Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:16:03.631328Z","time spent":"321.267232ms","remote":"127.0.0.1:54958","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1471,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T08:16:03.952752Z","caller":"traceutil/trace.go:171","msg":"trace[1613329964] linearizableReadLoop","detail":"{readStateIndex:1952; appliedIndex:1948; }","duration":"287.721709ms","start":"2026-06-10T08:16:03.664978Z","end":"2026-06-10T08:16:03.9527Z","steps":["trace[1613329964] 'read index received' (duration: 11.524897ms)","trace[1613329964] 'applied index is now lower than readState.Index' (duration: 276.192852ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:16:03.952991Z","caller":"traceutil/trace.go:171","msg":"trace[1817728698] transaction","detail":"{read_only:false; response_revision:1878; number_of_response:1; }","duration":"321.090019ms","start":"2026-06-10T08:16:03.631649Z","end":"2026-06-10T08:16:03.952739Z","steps":["trace[1817728698] 'process raft request' (duration: 320.65303ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:16:03.953228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.22359ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-06-10T08:16:03.953516Z","caller":"traceutil/trace.go:171","msg":"trace[1665044517] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1878; }","duration":"288.578066ms","start":"2026-06-10T08:16:03.664894Z","end":"2026-06-10T08:16:03.953472Z","steps":["trace[1665044517] 'agreement among raft nodes before linearized reading' (duration: 288.077997ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:16:03.953559Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:16:03.631606Z","time spent":"321.736381ms","remote":"127.0.0.1:54846","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":977,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T08:17:33.996466Z","caller":"traceutil/trace.go:171","msg":"trace[2029751618] transaction","detail":"{read_only:false; response_revision:2588; number_of_response:1; }","duration":"112.342687ms","start":"2026-06-10T08:17:33.8841Z","end":"2026-06-10T08:17:33.996443Z","steps":["trace[2029751618] 'process raft request' (duration: 112.179134ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:18:07.493632Z","caller":"traceutil/trace.go:171","msg":"trace[413377372] transaction","detail":"{read_only:false; response_revision:2792; number_of_response:1; }","duration":"119.30298ms","start":"2026-06-10T08:18:07.374299Z","end":"2026-06-10T08:18:07.493602Z","steps":["trace[413377372] 'process raft request' (duration: 119.091175ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:22:10.180366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.144393ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12210"} {"level":"info","ts":"2026-06-10T08:22:10.180444Z","caller":"traceutil/trace.go:171","msg":"trace[1910097497] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4856; }","duration":"107.275376ms","start":"2026-06-10T08:22:10.073153Z","end":"2026-06-10T08:22:10.180428Z","steps":["trace[1910097497] 'range keys from in-memory index tree' (duration: 106.508761ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:22:13.486002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.128137ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T08:22:13.486104Z","caller":"traceutil/trace.go:171","msg":"trace[373593663] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:5028; }","duration":"185.29561ms","start":"2026-06-10T08:22:13.300786Z","end":"2026-06-10T08:22:13.486082Z","steps":["trace[373593663] 'count revisions from in-memory index tree' (duration: 185.049724ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:22:13.486283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.427484ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-5fdbg-tls\" ","response":"range_response_count:1 size:1965"} {"level":"warn","ts":"2026-06-10T08:22:13.486305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.972228ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T08:22:13.486367Z","caller":"traceutil/trace.go:171","msg":"trace[1777867531] range","detail":"{range_begin:/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-5fdbg-tls; range_end:; response_count:1; response_revision:5028; }","duration":"219.521816ms","start":"2026-06-10T08:22:13.266825Z","end":"2026-06-10T08:22:13.486347Z","steps":["trace[1777867531] 'range keys from in-memory index tree' (duration: 219.315731ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:22:13.486362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.549735ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/monitoring/vector\" ","response":"range_response_count:1 size:894"} {"level":"info","ts":"2026-06-10T08:22:13.486393Z","caller":"traceutil/trace.go:171","msg":"trace[356061569] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5028; }","duration":"207.117871ms","start":"2026-06-10T08:22:13.279253Z","end":"2026-06-10T08:22:13.486371Z","steps":["trace[356061569] 'range keys from in-memory index tree' (duration: 206.852897ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:22:13.486464Z","caller":"traceutil/trace.go:171","msg":"trace[2105598128] range","detail":"{range_begin:/registry/serviceaccounts/monitoring/vector; range_end:; response_count:1; response_revision:5028; }","duration":"229.688857ms","start":"2026-06-10T08:22:13.256753Z","end":"2026-06-10T08:22:13.486441Z","steps":["trace[2105598128] 'range keys from in-memory index tree' (duration: 229.378252ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:22:13.88101Z","caller":"traceutil/trace.go:171","msg":"trace[200849906] transaction","detail":"{read_only:false; response_revision:5033; number_of_response:1; }","duration":"169.168095ms","start":"2026-06-10T08:22:13.711797Z","end":"2026-06-10T08:22:13.880965Z","steps":["trace[200849906] 'process raft request' (duration: 168.880109ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:22:25.212211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.26524ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-10T08:22:25.212545Z","caller":"traceutil/trace.go:171","msg":"trace[276759777] transaction","detail":"{read_only:false; response_revision:5268; number_of_response:1; }","duration":"144.944186ms","start":"2026-06-10T08:22:25.067585Z","end":"2026-06-10T08:22:25.212529Z","steps":["trace[276759777] 'process raft request' (duration: 32.284399ms)","trace[276759777] 'compare' (duration: 112.173818ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:22:25.212542Z","caller":"traceutil/trace.go:171","msg":"trace[1208012754] transaction","detail":"{read_only:false; response_revision:5269; number_of_response:1; }","duration":"143.814906ms","start":"2026-06-10T08:22:25.068709Z","end":"2026-06-10T08:22:25.212524Z","steps":["trace[1208012754] 'process raft request' (duration: 143.590892ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:22:34.589682Z","caller":"traceutil/trace.go:171","msg":"trace[256795139] transaction","detail":"{read_only:false; response_revision:5457; number_of_response:1; }","duration":"155.728784ms","start":"2026-06-10T08:22:34.433923Z","end":"2026-06-10T08:22:34.589652Z","steps":["trace[256795139] 'process raft request' (duration: 126.19869ms)","trace[256795139] 'compare' (duration: 29.225688ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:23:36.854886Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2955} {"level":"info","ts":"2026-06-10T08:23:36.920406Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2955,"took":"63.737958ms","hash":3829940966,"current-db-size-bytes":57495552,"current-db-size":"58 MB","current-db-size-in-use-bytes":33861632,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-06-10T08:23:36.920461Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3829940966,"revision":2955,"compact-revision":-1} {"level":"info","ts":"2026-06-10T08:28:36.861347Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6032} {"level":"info","ts":"2026-06-10T08:28:36.964683Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6032,"took":"101.399204ms","hash":295645482,"current-db-size-bytes":57495552,"current-db-size":"58 MB","current-db-size-in-use-bytes":21278720,"current-db-size-in-use":"21 MB"} {"level":"info","ts":"2026-06-10T08:28:36.964761Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":295645482,"revision":6032,"compact-revision":2955} {"level":"info","ts":"2026-06-10T08:28:42.32655Z","caller":"traceutil/trace.go:171","msg":"trace[1791404470] transaction","detail":"{read_only:false; response_revision:8279; number_of_response:1; }","duration":"407.964504ms","start":"2026-06-10T08:28:41.918557Z","end":"2026-06-10T08:28:42.326522Z","steps":["trace[1791404470] 'process raft request' (duration: 407.756869ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:28:42.326811Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:28:41.918527Z","time spent":"408.139107ms","remote":"127.0.0.1:54942","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T08:28:42.328641Z","caller":"traceutil/trace.go:171","msg":"trace[1105935886] linearizableReadLoop","detail":"{readStateIndex:8571; appliedIndex:8569; }","duration":"146.98722ms","start":"2026-06-10T08:28:42.181631Z","end":"2026-06-10T08:28:42.328618Z","steps":["trace[1105935886] 'read index received' (duration: 144.715566ms)","trace[1105935886] 'applied index is now lower than readState.Index' (duration: 2.270604ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:28:42.328944Z","caller":"traceutil/trace.go:171","msg":"trace[119204839] transaction","detail":"{read_only:false; response_revision:8280; number_of_response:1; }","duration":"295.831135ms","start":"2026-06-10T08:28:42.033082Z","end":"2026-06-10T08:28:42.328913Z","steps":["trace[119204839] 'process raft request' (duration: 295.414988ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:28:42.329091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.445048ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-vkqcl\" ","response":"range_response_count:1 size:6437"} {"level":"info","ts":"2026-06-10T08:28:42.32915Z","caller":"traceutil/trace.go:171","msg":"trace[928647770] range","detail":"{range_begin:/registry/pods/openstack/keepalived-vkqcl; range_end:; response_count:1; response_revision:8280; }","duration":"147.56226ms","start":"2026-06-10T08:28:42.181574Z","end":"2026-06-10T08:28:42.329136Z","steps":["trace[928647770] 'agreement among raft nodes before linearized reading' (duration: 147.361757ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:28:54.085523Z","caller":"traceutil/trace.go:171","msg":"trace[1418014971] transaction","detail":"{read_only:false; response_revision:8338; number_of_response:1; }","duration":"431.648003ms","start":"2026-06-10T08:28:53.653847Z","end":"2026-06-10T08:28:54.085495Z","steps":["trace[1418014971] 'process raft request' (duration: 431.48228ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:28:54.085799Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:28:53.653832Z","time spent":"431.840636ms","remote":"127.0.0.1:54942","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T08:28:54.142761Z","caller":"traceutil/trace.go:171","msg":"trace[1731613341] linearizableReadLoop","detail":"{readStateIndex:8632; appliedIndex:8630; }","duration":"474.884153ms","start":"2026-06-10T08:28:53.667849Z","end":"2026-06-10T08:28:54.142733Z","steps":["trace[1731613341] 'read index received' (duration: 417.467444ms)","trace[1731613341] 'applied index is now lower than readState.Index' (duration: 57.415779ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:28:54.142787Z","caller":"traceutil/trace.go:171","msg":"trace[759327488] transaction","detail":"{read_only:false; response_revision:8339; number_of_response:1; }","duration":"487.955132ms","start":"2026-06-10T08:28:53.654798Z","end":"2026-06-10T08:28:54.142753Z","steps":["trace[759327488] 'process raft request' (duration: 487.80113ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:28:54.142943Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:28:53.654786Z","time spent":"488.081544ms","remote":"127.0.0.1:54942","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T08:28:54.142972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"471.918457ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-06-10T08:28:54.143005Z","caller":"traceutil/trace.go:171","msg":"trace[569097349] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8339; }","duration":"471.986179ms","start":"2026-06-10T08:28:53.671005Z","end":"2026-06-10T08:28:54.142991Z","steps":["trace[569097349] 'agreement among raft nodes before linearized reading' (duration: 471.851516ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:28:54.142992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"475.117107ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-06-10T08:28:54.143012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.045946ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-10T08:28:54.143039Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:28:53.670992Z","time spent":"472.040739ms","remote":"127.0.0.1:54942","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-10T08:28:54.143053Z","caller":"traceutil/trace.go:171","msg":"trace[325967176] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8339; }","duration":"475.22228ms","start":"2026-06-10T08:28:53.667816Z","end":"2026-06-10T08:28:54.143038Z","steps":["trace[325967176] 'agreement among raft nodes before linearized reading' (duration: 475.012666ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:28:54.143058Z","caller":"traceutil/trace.go:171","msg":"trace[1644133708] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:8339; }","duration":"122.151158ms","start":"2026-06-10T08:28:54.020894Z","end":"2026-06-10T08:28:54.143045Z","steps":["trace[1644133708] 'agreement among raft nodes before linearized reading' (duration: 122.070706ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:28:54.143097Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:28:53.667803Z","time spent":"475.287521ms","remote":"127.0.0.1:54942","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-10T08:28:54.850246Z","caller":"traceutil/trace.go:171","msg":"trace[5531767] transaction","detail":"{read_only:false; response_revision:8344; number_of_response:1; }","duration":"215.680104ms","start":"2026-06-10T08:28:54.63454Z","end":"2026-06-10T08:28:54.850221Z","steps":["trace[5531767] 'process raft request' (duration: 215.521841ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:28:54.857135Z","caller":"traceutil/trace.go:171","msg":"trace[227398097] transaction","detail":"{read_only:false; response_revision:8345; number_of_response:1; }","duration":"212.178956ms","start":"2026-06-10T08:28:54.644928Z","end":"2026-06-10T08:28:54.857107Z","steps":["trace[227398097] 'process raft request' (duration: 212.046744ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:28:55.561165Z","caller":"traceutil/trace.go:171","msg":"trace[732640525] transaction","detail":"{read_only:false; response_revision:8347; number_of_response:1; }","duration":"107.50093ms","start":"2026-06-10T08:28:55.453635Z","end":"2026-06-10T08:28:55.561136Z","steps":["trace[732640525] 'process raft request' (duration: 107.317087ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:28:56.321325Z","caller":"traceutil/trace.go:171","msg":"trace[1757495531] transaction","detail":"{read_only:false; response_revision:8351; number_of_response:1; }","duration":"116.92259ms","start":"2026-06-10T08:28:56.204366Z","end":"2026-06-10T08:28:56.321289Z","steps":["trace[1757495531] 'process raft request' (duration: 20.319916ms)","trace[1757495531] 'compare' (duration: 96.38515ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:29:23.137369Z","caller":"traceutil/trace.go:171","msg":"trace[1694180082] transaction","detail":"{read_only:false; response_revision:8548; number_of_response:1; }","duration":"182.582074ms","start":"2026-06-10T08:29:22.954764Z","end":"2026-06-10T08:29:23.137346Z","steps":["trace[1694180082] 'process raft request' (duration: 182.414721ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:29:23.334314Z","caller":"traceutil/trace.go:171","msg":"trace[176605162] linearizableReadLoop","detail":"{readStateIndex:8850; appliedIndex:8848; }","duration":"217.619839ms","start":"2026-06-10T08:29:23.116672Z","end":"2026-06-10T08:29:23.334292Z","steps":["trace[176605162] 'read index received' (duration: 20.546389ms)","trace[176605162] 'applied index is now lower than readState.Index' (duration: 197.07252ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:29:23.334552Z","caller":"traceutil/trace.go:171","msg":"trace[313612773] transaction","detail":"{read_only:false; response_revision:8549; number_of_response:1; }","duration":"379.528501ms","start":"2026-06-10T08:29:22.95501Z","end":"2026-06-10T08:29:23.334539Z","steps":["trace[313612773] 'process raft request' (duration: 298.547054ms)","trace[313612773] 'compare' (duration: 80.631851ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T08:29:23.334631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.533833ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/\" range_end:\"/registry/rabbitmq.com/rabbitmqclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-10T08:29:23.334658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.219763ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-10T08:29:23.334698Z","caller":"traceutil/trace.go:171","msg":"trace[1403128613] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/; range_end:/registry/rabbitmq.com/rabbitmqclusters0; response_count:0; response_revision:8549; }","duration":"212.660946ms","start":"2026-06-10T08:29:23.122018Z","end":"2026-06-10T08:29:23.334679Z","steps":["trace[1403128613] 'agreement among raft nodes before linearized reading' (duration: 212.527743ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:29:23.334734Z","caller":"traceutil/trace.go:171","msg":"trace[1293425285] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:8549; }","duration":"109.354465ms","start":"2026-06-10T08:29:23.225361Z","end":"2026-06-10T08:29:23.334715Z","steps":["trace[1293425285] 'agreement among raft nodes before linearized reading' (duration: 109.208923ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:29:23.334725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.817352ms","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-06-10T08:29:23.334801Z","caller":"traceutil/trace.go:171","msg":"trace[883217045] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8549; }","duration":"198.925264ms","start":"2026-06-10T08:29:23.135858Z","end":"2026-06-10T08:29:23.334784Z","steps":["trace[883217045] 'agreement among raft nodes before linearized reading' (duration: 198.736411ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:29:23.334924Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:29:22.954973Z","time spent":"379.789426ms","remote":"127.0.0.1:54942","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T08:29:23.335183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.889523ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-10T08:29:23.335417Z","caller":"traceutil/trace.go:171","msg":"trace[629778053] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:8549; }","duration":"218.683859ms","start":"2026-06-10T08:29:23.116664Z","end":"2026-06-10T08:29:23.335348Z","steps":["trace[629778053] 'agreement among raft nodes before linearized reading' (duration: 217.846083ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:29:35.38929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.722466ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-06-10T08:29:35.389556Z","caller":"traceutil/trace.go:171","msg":"trace[87011634] transaction","detail":"{read_only:false; response_revision:8653; number_of_response:1; }","duration":"186.218823ms","start":"2026-06-10T08:29:35.203316Z","end":"2026-06-10T08:29:35.389535Z","steps":["trace[87011634] 'process raft request' (duration: 186.085591ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:29:35.733063Z","caller":"traceutil/trace.go:171","msg":"trace[1964291152] transaction","detail":"{read_only:false; response_revision:8654; number_of_response:1; }","duration":"283.662611ms","start":"2026-06-10T08:29:35.44937Z","end":"2026-06-10T08:29:35.733032Z","steps":["trace[1964291152] 'process raft request' (duration: 252.032482ms)","trace[1964291152] 'compare' (duration: 31.443956ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:29:35.733162Z","caller":"traceutil/trace.go:171","msg":"trace[497965680] linearizableReadLoop","detail":"{readStateIndex:8963; appliedIndex:8962; }","duration":"257.640988ms","start":"2026-06-10T08:29:35.475497Z","end":"2026-06-10T08:29:35.733138Z","steps":["trace[497965680] 'read index received' (duration: 225.915567ms)","trace[497965680] 'applied index is now lower than readState.Index' (duration: 31.724001ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T08:29:35.73331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.787772ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-10T08:29:35.733344Z","caller":"traceutil/trace.go:171","msg":"trace[819464790] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:8655; }","duration":"257.885494ms","start":"2026-06-10T08:29:35.475447Z","end":"2026-06-10T08:29:35.733332Z","steps":["trace[819464790] 'agreement among raft nodes before linearized reading' (duration: 257.806022ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:29:35.733425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.707161ms","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-06-10T08:29:35.733489Z","caller":"traceutil/trace.go:171","msg":"trace[1336127442] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8655; }","duration":"207.794093ms","start":"2026-06-10T08:29:35.52566Z","end":"2026-06-10T08:29:35.733454Z","steps":["trace[1336127442] 'agreement among raft nodes before linearized reading' (duration: 207.649271ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:29:36.487595Z","caller":"traceutil/trace.go:171","msg":"trace[323841721] linearizableReadLoop","detail":"{readStateIndex:8968; appliedIndex:8967; }","duration":"117.156142ms","start":"2026-06-10T08:29:36.370414Z","end":"2026-06-10T08:29:36.48757Z","steps":["trace[323841721] 'read index received' (duration: 116.964498ms)","trace[323841721] 'applied index is now lower than readState.Index' (duration: 190.634µs)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:29:36.487677Z","caller":"traceutil/trace.go:171","msg":"trace[192360126] transaction","detail":"{read_only:false; response_revision:8659; number_of_response:1; }","duration":"120.241531ms","start":"2026-06-10T08:29:36.36739Z","end":"2026-06-10T08:29:36.487631Z","steps":["trace[192360126] 'process raft request' (duration: 120.038667ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:29:36.488036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.597242ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-06-10T08:29:36.488114Z","caller":"traceutil/trace.go:171","msg":"trace[375729000] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8659; }","duration":"117.764635ms","start":"2026-06-10T08:29:36.370332Z","end":"2026-06-10T08:29:36.488096Z","steps":["trace[375729000] 'agreement among raft nodes before linearized reading' (duration: 117.349386ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:29:54.437795Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000023de.wal"} {"level":"info","ts":"2026-06-10T08:30:52.26265Z","caller":"traceutil/trace.go:171","msg":"trace[306166513] transaction","detail":"{read_only:false; response_revision:9401; number_of_response:1; }","duration":"245.105761ms","start":"2026-06-10T08:30:52.017518Z","end":"2026-06-10T08:30:52.262624Z","steps":["trace[306166513] 'process raft request' (duration: 244.841596ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:30:52.266776Z","caller":"traceutil/trace.go:171","msg":"trace[1744488799] linearizableReadLoop","detail":"{readStateIndex:9730; appliedIndex:9728; }","duration":"161.899231ms","start":"2026-06-10T08:30:52.104851Z","end":"2026-06-10T08:30:52.26675Z","steps":["trace[1744488799] 'read index received' (duration: 157.493818ms)","trace[1744488799] 'applied index is now lower than readState.Index' (duration: 4.404083ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:30:52.266923Z","caller":"traceutil/trace.go:171","msg":"trace[782960354] transaction","detail":"{read_only:false; response_revision:9402; number_of_response:1; }","duration":"247.302842ms","start":"2026-06-10T08:30:52.019587Z","end":"2026-06-10T08:30:52.26689Z","steps":["trace[782960354] 'process raft request' (duration: 247.015067ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:30:52.267052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.171437ms","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-06-10T08:30:52.267138Z","caller":"traceutil/trace.go:171","msg":"trace[277607863] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:9402; }","duration":"162.32012ms","start":"2026-06-10T08:30:52.104804Z","end":"2026-06-10T08:30:52.267124Z","steps":["trace[277607863] 'agreement among raft nodes before linearized reading' (duration: 162.087196ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:30:52.392563Z","caller":"traceutil/trace.go:171","msg":"trace[2135171007] transaction","detail":"{read_only:false; response_revision:9403; number_of_response:1; }","duration":"121.541696ms","start":"2026-06-10T08:30:52.270993Z","end":"2026-06-10T08:30:52.392535Z","steps":["trace[2135171007] 'process raft request' (duration: 92.19046ms)","trace[2135171007] 'compare' (duration: 29.01001ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:30:52.392574Z","caller":"traceutil/trace.go:171","msg":"trace[608018510] transaction","detail":"{read_only:false; response_revision:9404; number_of_response:1; }","duration":"121.348253ms","start":"2026-06-10T08:30:52.271208Z","end":"2026-06-10T08:30:52.392556Z","steps":["trace[608018510] 'process raft request' (duration: 121.246811ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:31:27.137105Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"597401b06ce1cf3d","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-10T08:31:27.142241Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-06-10T08:31:27.142321Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-06-10T08:33:36.867084Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8112} {"level":"info","ts":"2026-06-10T08:33:36.923272Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8112,"took":"54.560107ms","hash":2950054501,"current-db-size-bytes":57495552,"current-db-size":"58 MB","current-db-size-in-use-bytes":29478912,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-06-10T08:33:36.923323Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2950054501,"revision":8112,"compact-revision":6032} {"level":"warn","ts":"2026-06-10T08:34:43.44374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.248317ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-10T08:34:43.444006Z","caller":"traceutil/trace.go:171","msg":"trace[988620244] linearizableReadLoop","detail":"{readStateIndex:11674; appliedIndex:11673; }","duration":"163.889834ms","start":"2026-06-10T08:34:43.280091Z","end":"2026-06-10T08:34:43.443981Z","steps":["trace[988620244] 'read index received' (duration: 45.134097ms)","trace[988620244] 'applied index is now lower than readState.Index' (duration: 118.753187ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:34:43.444107Z","caller":"traceutil/trace.go:171","msg":"trace[428454902] transaction","detail":"{read_only:false; response_revision:11290; number_of_response:1; }","duration":"222.65009ms","start":"2026-06-10T08:34:43.221401Z","end":"2026-06-10T08:34:43.444051Z","steps":["trace[428454902] 'process raft request' (duration: 103.939814ms)","trace[428454902] 'compare' (duration: 117.865759ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T08:34:43.44416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.046557ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T08:34:43.444268Z","caller":"traceutil/trace.go:171","msg":"trace[840655338] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:11290; }","duration":"164.199309ms","start":"2026-06-10T08:34:43.280037Z","end":"2026-06-10T08:34:43.444236Z","steps":["trace[840655338] 'agreement among raft nodes before linearized reading' (duration: 164.008676ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:38:36.876442Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10708} {"level":"info","ts":"2026-06-10T08:38:36.960483Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10708,"took":"81.760892ms","hash":2516664248,"current-db-size-bytes":57495552,"current-db-size":"58 MB","current-db-size-in-use-bytes":27017216,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-06-10T08:38:36.960539Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2516664248,"revision":10708,"compact-revision":8112} {"level":"info","ts":"2026-06-10T08:40:51.971015Z","caller":"traceutil/trace.go:171","msg":"trace[348211052] transaction","detail":"{read_only:false; response_revision:13781; number_of_response:1; }","duration":"117.981809ms","start":"2026-06-10T08:40:51.852984Z","end":"2026-06-10T08:40:51.970965Z","steps":["trace[348211052] 'process raft request' (duration: 117.595431ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:40:52.079595Z","caller":"traceutil/trace.go:171","msg":"trace[1887968719] transaction","detail":"{read_only:false; response_revision:13784; number_of_response:1; }","duration":"100.079639ms","start":"2026-06-10T08:40:51.979462Z","end":"2026-06-10T08:40:52.079542Z","steps":["trace[1887968719] 'process raft request' (duration: 99.800824ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:40:52.079886Z","caller":"traceutil/trace.go:171","msg":"trace[1627295557] transaction","detail":"{read_only:false; response_revision:13785; number_of_response:1; }","duration":"100.305572ms","start":"2026-06-10T08:40:51.979469Z","end":"2026-06-10T08:40:52.079774Z","steps":["trace[1627295557] 'process raft request' (duration: 100.031907ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:41:10.801284Z","caller":"traceutil/trace.go:171","msg":"trace[1884896988] transaction","detail":"{read_only:false; response_revision:13897; number_of_response:1; }","duration":"138.884095ms","start":"2026-06-10T08:41:10.66237Z","end":"2026-06-10T08:41:10.801254Z","steps":["trace[1884896988] 'process raft request' (duration: 138.661421ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:41:20.340094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.275269ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-10T08:41:20.340225Z","caller":"traceutil/trace.go:171","msg":"trace[1449095618] transaction","detail":"{read_only:false; response_revision:14062; number_of_response:1; }","duration":"240.208087ms","start":"2026-06-10T08:41:20.099996Z","end":"2026-06-10T08:41:20.340204Z","steps":["trace[1449095618] 'process raft request' (duration: 87.725994ms)","trace[1449095618] 'compare' (duration: 152.132176ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:41:20.415842Z","caller":"traceutil/trace.go:171","msg":"trace[1563147509] linearizableReadLoop","detail":"{readStateIndex:14542; appliedIndex:14540; }","duration":"247.202899ms","start":"2026-06-10T08:41:20.168614Z","end":"2026-06-10T08:41:20.415817Z","steps":["trace[1563147509] 'read index received' (duration: 19.188933ms)","trace[1563147509] 'applied index is now lower than readState.Index' (duration: 228.012486ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:41:20.416064Z","caller":"traceutil/trace.go:171","msg":"trace[293389062] transaction","detail":"{read_only:false; response_revision:14063; number_of_response:1; }","duration":"304.67815ms","start":"2026-06-10T08:41:20.111224Z","end":"2026-06-10T08:41:20.415902Z","steps":["trace[293389062] 'process raft request' (duration: 304.372674ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:41:20.416259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.613098ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-ab4fc012-398e-4c67-937b-6e6a99eab3dc\" ","response":"range_response_count:1 size:3605"} {"level":"info","ts":"2026-06-10T08:41:20.416384Z","caller":"traceutil/trace.go:171","msg":"trace[1534301239] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-ab4fc012-398e-4c67-937b-6e6a99eab3dc; range_end:; response_count:1; response_revision:14063; }","duration":"247.787251ms","start":"2026-06-10T08:41:20.168571Z","end":"2026-06-10T08:41:20.416358Z","steps":["trace[1534301239] 'agreement among raft nodes before linearized reading' (duration: 247.369763ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:41:20.416547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.016228ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"warn","ts":"2026-06-10T08:41:20.41659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.951029ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-10T08:41:20.416598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.091038ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/ovn-controller-default-mfj4d.18b7ab9f6653e38a\" ","response":"range_response_count:1 size:783"} {"level":"info","ts":"2026-06-10T08:41:20.416637Z","caller":"traceutil/trace.go:171","msg":"trace[282673743] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:14063; }","duration":"136.02406ms","start":"2026-06-10T08:41:20.280599Z","end":"2026-06-10T08:41:20.416623Z","steps":["trace[282673743] 'agreement among raft nodes before linearized reading' (duration: 135.944349ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:41:20.416671Z","caller":"traceutil/trace.go:171","msg":"trace[1539642650] range","detail":"{range_begin:/registry/events/openstack/ovn-controller-default-mfj4d.18b7ab9f6653e38a; range_end:; response_count:1; response_revision:14063; }","duration":"130.173389ms","start":"2026-06-10T08:41:20.286478Z","end":"2026-06-10T08:41:20.416652Z","steps":["trace[1539642650] 'agreement among raft nodes before linearized reading' (duration: 129.977426ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:41:20.416817Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:41:20.111189Z","time spent":"305.079507ms","remote":"127.0.0.1:54752","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":117,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T08:41:20.416171Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.611941ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-10T08:41:20.417054Z","caller":"traceutil/trace.go:171","msg":"trace[1042944170] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:14063; }","duration":"226.568139ms","start":"2026-06-10T08:41:20.190473Z","end":"2026-06-10T08:41:20.417041Z","steps":["trace[1042944170] 'agreement among raft nodes before linearized reading' (duration: 225.508458ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:41:20.416836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.082158ms","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-06-10T08:41:20.417175Z","caller":"traceutil/trace.go:171","msg":"trace[892433946] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:14063; }","duration":"130.438075ms","start":"2026-06-10T08:41:20.286724Z","end":"2026-06-10T08:41:20.417162Z","steps":["trace[892433946] 'agreement among raft nodes before linearized reading' (duration: 130.035997ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:41:20.416633Z","caller":"traceutil/trace.go:171","msg":"trace[2128072753] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:14063; }","duration":"109.12352ms","start":"2026-06-10T08:41:20.307487Z","end":"2026-06-10T08:41:20.416611Z","steps":["trace[2128072753] 'agreement among raft nodes before linearized reading' (duration: 108.879725ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:43:00.52796Z","caller":"traceutil/trace.go:171","msg":"trace[1938028359] linearizableReadLoop","detail":"{readStateIndex:15663; appliedIndex:15662; }","duration":"148.787424ms","start":"2026-06-10T08:43:00.379152Z","end":"2026-06-10T08:43:00.52794Z","steps":["trace[1938028359] 'read index received' (duration: 148.58363ms)","trace[1938028359] 'applied index is now lower than readState.Index' (duration: 202.544µs)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:43:00.528308Z","caller":"traceutil/trace.go:171","msg":"trace[1195847940] transaction","detail":"{read_only:false; response_revision:15150; number_of_response:1; }","duration":"166.362497ms","start":"2026-06-10T08:43:00.361929Z","end":"2026-06-10T08:43:00.528291Z","steps":["trace[1195847940] 'process raft request' (duration: 165.873318ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:43:00.528579Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.403786ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T08:43:00.528625Z","caller":"traceutil/trace.go:171","msg":"trace[2045499388] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:15150; }","duration":"149.523968ms","start":"2026-06-10T08:43:00.379088Z","end":"2026-06-10T08:43:00.528612Z","steps":["trace[2045499388] 'agreement among raft nodes before linearized reading' (duration: 149.426176ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:43:00.528825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.456567ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-endpoints\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T08:43:00.528863Z","caller":"traceutil/trace.go:171","msg":"trace[144548173] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-endpoints; range_end:; response_count:0; response_revision:15150; }","duration":"149.520568ms","start":"2026-06-10T08:43:00.379334Z","end":"2026-06-10T08:43:00.528855Z","steps":["trace[144548173] 'agreement among raft nodes before linearized reading' (duration: 149.461737ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:43:00.529491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.279388ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5448"} {"level":"info","ts":"2026-06-10T08:43:00.529532Z","caller":"traceutil/trace.go:171","msg":"trace[494150860] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:15150; }","duration":"144.33808ms","start":"2026-06-10T08:43:00.385185Z","end":"2026-06-10T08:43:00.529523Z","steps":["trace[494150860] 'agreement among raft nodes before linearized reading' (duration: 144.242938ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:43:00.529696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.588719ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5448"} {"level":"info","ts":"2026-06-10T08:43:00.52973Z","caller":"traceutil/trace.go:171","msg":"trace[686445950] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:15150; }","duration":"149.639999ms","start":"2026-06-10T08:43:00.380082Z","end":"2026-06-10T08:43:00.529722Z","steps":["trace[686445950] 'agreement among raft nodes before linearized reading' (duration: 149.557568ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:43:00.529812Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.264443ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-user\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T08:43:00.529844Z","caller":"traceutil/trace.go:171","msg":"trace[1039353733] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-user; range_end:; response_count:0; response_revision:15150; }","duration":"150.354815ms","start":"2026-06-10T08:43:00.379482Z","end":"2026-06-10T08:43:00.529837Z","steps":["trace[1039353733] 'agreement among raft nodes before linearized reading' (duration: 150.311484ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:43:00.999224Z","caller":"traceutil/trace.go:171","msg":"trace[1720764684] transaction","detail":"{read_only:false; response_revision:15152; number_of_response:1; }","duration":"187.918087ms","start":"2026-06-10T08:43:00.811279Z","end":"2026-06-10T08:43:00.999197Z","steps":["trace[1720764684] 'process raft request' (duration: 187.481408ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:43:36.882444Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12805} {"level":"info","ts":"2026-06-10T08:43:36.965223Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12805,"took":"79.832815ms","hash":3779163815,"current-db-size-bytes":57495552,"current-db-size":"58 MB","current-db-size-in-use-bytes":30449664,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-06-10T08:43:36.9653Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3779163815,"revision":12805,"compact-revision":10708} {"level":"info","ts":"2026-06-10T08:48:36.888546Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15370} {"level":"info","ts":"2026-06-10T08:48:37.180563Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15370,"took":"288.661348ms","hash":3588813323,"current-db-size-bytes":57495552,"current-db-size":"58 MB","current-db-size-in-use-bytes":32649216,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-06-10T08:48:37.18063Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3588813323,"revision":15370,"compact-revision":12805} {"level":"info","ts":"2026-06-10T08:48:43.131978Z","caller":"traceutil/trace.go:171","msg":"trace[1378691244] linearizableReadLoop","detail":"{readStateIndex:18381; appliedIndex:18380; }","duration":"153.466352ms","start":"2026-06-10T08:48:42.978486Z","end":"2026-06-10T08:48:43.131953Z","steps":["trace[1378691244] 'read index received' (duration: 153.218598ms)","trace[1378691244] 'applied index is now lower than readState.Index' (duration: 246.364µs)"],"step_count":2} {"level":"warn","ts":"2026-06-10T08:48:43.13221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.697706ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/libvirt-libvirt-default-q86lp\" ","response":"range_response_count:1 size:20763"} {"level":"info","ts":"2026-06-10T08:48:43.132244Z","caller":"traceutil/trace.go:171","msg":"trace[299254083] range","detail":"{range_begin:/registry/pods/openstack/libvirt-libvirt-default-q86lp; range_end:; response_count:1; response_revision:17784; }","duration":"153.784768ms","start":"2026-06-10T08:48:42.97845Z","end":"2026-06-10T08:48:43.132235Z","steps":["trace[299254083] 'agreement among raft nodes before linearized reading' (duration: 153.613205ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:48:43.132635Z","caller":"traceutil/trace.go:171","msg":"trace[454458356] transaction","detail":"{read_only:false; response_revision:17784; number_of_response:1; }","duration":"165.521481ms","start":"2026-06-10T08:48:42.967077Z","end":"2026-06-10T08:48:43.132598Z","steps":["trace[454458356] 'process raft request' (duration: 164.700475ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:48:43.872302Z","caller":"traceutil/trace.go:171","msg":"trace[1929070311] transaction","detail":"{read_only:false; response_revision:17786; number_of_response:1; }","duration":"187.387613ms","start":"2026-06-10T08:48:43.684892Z","end":"2026-06-10T08:48:43.872279Z","steps":["trace[1929070311] 'process raft request' (duration: 187.21896ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:48:43.885232Z","caller":"traceutil/trace.go:171","msg":"trace[533193255] transaction","detail":"{read_only:false; response_revision:17787; number_of_response:1; }","duration":"189.480032ms","start":"2026-06-10T08:48:43.695725Z","end":"2026-06-10T08:48:43.885205Z","steps":["trace[533193255] 'process raft request' (duration: 189.119386ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:51:56.455214Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"597401b06ce1cf3d","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-10T08:51:56.460693Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-06-10T08:51:56.460776Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-06-10T08:53:36.894621Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17743} {"level":"info","ts":"2026-06-10T08:53:36.993194Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17743,"took":"95.736957ms","hash":3641564492,"current-db-size-bytes":57495552,"current-db-size":"58 MB","current-db-size-in-use-bytes":34320384,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-06-10T08:53:36.993272Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3641564492,"revision":17743,"compact-revision":15370} {"level":"info","ts":"2026-06-10T08:54:09.586838Z","caller":"traceutil/trace.go:171","msg":"trace[1977014216] transaction","detail":"{read_only:false; response_revision:20267; number_of_response:1; }","duration":"120.338923ms","start":"2026-06-10T08:54:09.46647Z","end":"2026-06-10T08:54:09.586809Z","steps":["trace[1977014216] 'process raft request' (duration: 120.153319ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:54:15.635725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.898142ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-06-10T08:54:15.635978Z","caller":"traceutil/trace.go:171","msg":"trace[775623061] linearizableReadLoop","detail":"{readStateIndex:20980; appliedIndex:20979; }","duration":"121.28187ms","start":"2026-06-10T08:54:15.514674Z","end":"2026-06-10T08:54:15.635955Z","steps":["trace[775623061] 'read index received' (duration: 65.691µs)","trace[775623061] 'applied index is now lower than readState.Index' (duration: 121.215039ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T08:54:15.767453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.769882ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-octavia-server-0\" ","response":"range_response_count:1 size:1864"} {"level":"info","ts":"2026-06-10T08:54:15.767536Z","caller":"traceutil/trace.go:171","msg":"trace[1961233345] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-octavia-server-0; range_end:; response_count:1; response_revision:20300; }","duration":"252.893135ms","start":"2026-06-10T08:54:15.51462Z","end":"2026-06-10T08:54:15.767513Z","steps":["trace[1961233345] 'agreement among raft nodes before linearized reading' (duration: 121.408962ms)","trace[1961233345] 'range keys from in-memory index tree' (duration: 131.29608ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:54:16.119484Z","caller":"traceutil/trace.go:171","msg":"trace[956682794] linearizableReadLoop","detail":"{readStateIndex:20983; appliedIndex:20981; }","duration":"237.455015ms","start":"2026-06-10T08:54:15.881998Z","end":"2026-06-10T08:54:16.119453Z","steps":["trace[956682794] 'read index received' (duration: 46.64181ms)","trace[956682794] 'applied index is now lower than readState.Index' (duration: 190.811974ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:54:16.119594Z","caller":"traceutil/trace.go:171","msg":"trace[1707618724] transaction","detail":"{read_only:false; response_revision:20302; number_of_response:1; }","duration":"247.083707ms","start":"2026-06-10T08:54:15.8725Z","end":"2026-06-10T08:54:16.119583Z","steps":["trace[1707618724] 'process raft request' (duration: 237.653838ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:54:16.119756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.74612ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-10T08:54:16.119787Z","caller":"traceutil/trace.go:171","msg":"trace[581514596] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:20302; }","duration":"237.839401ms","start":"2026-06-10T08:54:15.881939Z","end":"2026-06-10T08:54:16.119779Z","steps":["trace[581514596] 'agreement among raft nodes before linearized reading' (duration: 237.75488ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:54:16.120013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.889839ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-06-10T08:54:16.120041Z","caller":"traceutil/trace.go:171","msg":"trace[1604892491] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:20302; }","duration":"142.940359ms","start":"2026-06-10T08:54:15.977092Z","end":"2026-06-10T08:54:16.120032Z","steps":["trace[1604892491] 'agreement among raft nodes before linearized reading' (duration: 142.836737ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:54:16.120473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.123794ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephblockpools/\" range_end:\"/registry/ceph.rook.io/cephblockpools0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T08:54:16.120574Z","caller":"traceutil/trace.go:171","msg":"trace[1220482740] range","detail":"{range_begin:/registry/ceph.rook.io/cephblockpools/; range_end:/registry/ceph.rook.io/cephblockpools0; response_count:0; response_revision:20302; }","duration":"132.293618ms","start":"2026-06-10T08:54:15.988257Z","end":"2026-06-10T08:54:16.12055Z","steps":["trace[1220482740] 'agreement among raft nodes before linearized reading' (duration: 131.991072ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:58:06.769521Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.640004ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephfilesystemsubvolumegroups/\" range_end:\"/registry/ceph.rook.io/cephfilesystemsubvolumegroups0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T08:58:06.769651Z","caller":"traceutil/trace.go:171","msg":"trace[1658010157] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystemsubvolumegroups/; range_end:/registry/ceph.rook.io/cephfilesystemsubvolumegroups0; response_count:0; response_revision:22701; }","duration":"106.859748ms","start":"2026-06-10T08:58:06.662758Z","end":"2026-06-10T08:58:06.769618Z","steps":["trace[1658010157] 'count revisions from in-memory index tree' (duration: 106.543031ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:58:36.901361Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":20103} {"level":"info","ts":"2026-06-10T08:58:37.020035Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":20103,"took":"114.733046ms","hash":2001498717,"current-db-size-bytes":57495552,"current-db-size":"58 MB","current-db-size-in-use-bytes":40755200,"current-db-size-in-use":"41 MB"} {"level":"info","ts":"2026-06-10T08:58:37.020094Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2001498717,"revision":20103,"compact-revision":17743} {"level":"info","ts":"2026-06-10T09:01:37.607004Z","caller":"traceutil/trace.go:171","msg":"trace[1376675385] linearizableReadLoop","detail":"{readStateIndex:25722; appliedIndex:25721; }","duration":"148.979407ms","start":"2026-06-10T09:01:37.457994Z","end":"2026-06-10T09:01:37.606973Z","steps":["trace[1376675385] 'read index received' (duration: 148.803574ms)","trace[1376675385] 'applied index is now lower than readState.Index' (duration: 174.053µs)"],"step_count":2} {"level":"info","ts":"2026-06-10T09:01:37.607047Z","caller":"traceutil/trace.go:171","msg":"trace[51748955] transaction","detail":"{read_only:false; response_revision:24916; number_of_response:1; }","duration":"186.841163ms","start":"2026-06-10T09:01:37.420179Z","end":"2026-06-10T09:01:37.60702Z","steps":["trace[51748955] 'process raft request' (duration: 186.615909ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T09:01:37.607221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.194451ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T09:01:37.607359Z","caller":"traceutil/trace.go:171","msg":"trace[1172691815] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:24916; }","duration":"149.402005ms","start":"2026-06-10T09:01:37.457933Z","end":"2026-06-10T09:01:37.607335Z","steps":["trace[1172691815] 'agreement among raft nodes before linearized reading' (duration: 149.189821ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T09:01:37.608457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.858719ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-magnum-server-0\" ","response":"range_response_count:1 size:1860"} {"level":"info","ts":"2026-06-10T09:01:37.608503Z","caller":"traceutil/trace.go:171","msg":"trace[2108358582] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-magnum-server-0; range_end:; response_count:1; response_revision:24917; }","duration":"125.930621ms","start":"2026-06-10T09:01:37.482559Z","end":"2026-06-10T09:01:37.60849Z","steps":["trace[2108358582] 'agreement among raft nodes before linearized reading' (duration: 125.743078ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T09:01:37.879765Z","caller":"traceutil/trace.go:171","msg":"trace[1250413146] transaction","detail":"{read_only:false; response_revision:24918; number_of_response:1; }","duration":"128.747234ms","start":"2026-06-10T09:01:37.750987Z","end":"2026-06-10T09:01:37.879734Z","steps":["trace[1250413146] 'process raft request' (duration: 35.249627ms)","trace[1250413146] 'compare' (duration: 93.308524ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T09:01:37.879747Z","caller":"traceutil/trace.go:171","msg":"trace[1789913014] linearizableReadLoop","detail":"{readStateIndex:25724; appliedIndex:25723; }","duration":"128.687523ms","start":"2026-06-10T09:01:37.751024Z","end":"2026-06-10T09:01:37.879711Z","steps":["trace[1789913014] 'read index received' (duration: 54.491µs)","trace[1789913014] 'applied index is now lower than readState.Index' (duration: 128.631632ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T09:01:37.879929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.874466ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephfilesystemsubvolumegroups/\" range_end:\"/registry/ceph.rook.io/cephfilesystemsubvolumegroups0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T09:01:37.880605Z","caller":"traceutil/trace.go:171","msg":"trace[159567689] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystemsubvolumegroups/; range_end:/registry/ceph.rook.io/cephfilesystemsubvolumegroups0; response_count:0; response_revision:24918; }","duration":"129.61521ms","start":"2026-06-10T09:01:37.750961Z","end":"2026-06-10T09:01:37.880576Z","steps":["trace[159567689] 'agreement among raft nodes before linearized reading' (duration: 128.848636ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T09:01:42.036417Z","caller":"traceutil/trace.go:171","msg":"trace[1074222750] linearizableReadLoop","detail":"{readStateIndex:25766; appliedIndex:25765; }","duration":"107.632054ms","start":"2026-06-10T09:01:41.928749Z","end":"2026-06-10T09:01:42.036381Z","steps":["trace[1074222750] 'read index received' (duration: 107.112405ms)","trace[1074222750] 'applied index is now lower than readState.Index' (duration: 517.039µs)"],"step_count":2} {"level":"warn","ts":"2026-06-10T09:01:42.036578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.796058ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T09:01:42.036494Z","caller":"traceutil/trace.go:171","msg":"trace[590538861] transaction","detail":"{read_only:false; response_revision:24959; number_of_response:1; }","duration":"141.911002ms","start":"2026-06-10T09:01:41.89453Z","end":"2026-06-10T09:01:42.036441Z","steps":["trace[590538861] 'process raft request' (duration: 141.425913ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T09:01:42.036657Z","caller":"traceutil/trace.go:171","msg":"trace[338452014] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:24959; }","duration":"107.952841ms","start":"2026-06-10T09:01:41.928688Z","end":"2026-06-10T09:01:42.036641Z","steps":["trace[338452014] 'agreement among raft nodes before linearized reading' (duration: 107.794258ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T09:01:42.199056Z","caller":"traceutil/trace.go:171","msg":"trace[557025312] transaction","detail":"{read_only:false; response_revision:24961; number_of_response:1; }","duration":"131.858754ms","start":"2026-06-10T09:01:42.067171Z","end":"2026-06-10T09:01:42.19903Z","steps":["trace[557025312] 'process raft request' (duration: 121.592229ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T09:01:42.199174Z","caller":"traceutil/trace.go:171","msg":"trace[1543211580] linearizableReadLoop","detail":"{readStateIndex:25769; appliedIndex:25767; }","duration":"104.625198ms","start":"2026-06-10T09:01:42.094526Z","end":"2026-06-10T09:01:42.199151Z","steps":["trace[1543211580] 'read index received' (duration: 94.19528ms)","trace[1543211580] 'applied index is now lower than readState.Index' (duration: 10.428818ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T09:01:42.199296Z","caller":"traceutil/trace.go:171","msg":"trace[2117939792] transaction","detail":"{read_only:false; response_revision:24962; number_of_response:1; }","duration":"107.419632ms","start":"2026-06-10T09:01:42.091866Z","end":"2026-06-10T09:01:42.199285Z","steps":["trace[2117939792] 'process raft request' (duration: 107.071485ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T09:01:42.199373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.833562ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12211"} {"level":"info","ts":"2026-06-10T09:01:42.199406Z","caller":"traceutil/trace.go:171","msg":"trace[1153059062] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:24962; }","duration":"104.902454ms","start":"2026-06-10T09:01:42.094495Z","end":"2026-06-10T09:01:42.199397Z","steps":["trace[1153059062] 'agreement among raft nodes before linearized reading' (duration: 104.740101ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T09:01:42.532959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.970494ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/machines/\" range_end:\"/registry/cluster.x-k8s.io/machines0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T09:01:42.533066Z","caller":"traceutil/trace.go:171","msg":"trace[522288005] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machines/; range_end:/registry/cluster.x-k8s.io/machines0; response_count:0; response_revision:24962; }","duration":"206.133437ms","start":"2026-06-10T09:01:42.326906Z","end":"2026-06-10T09:01:42.533039Z","steps":["trace[522288005] 'count revisions from in-memory index tree' (duration: 205.888513ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T09:01:42.53339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.537519ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-06-10T09:01:42.533434Z","caller":"traceutil/trace.go:171","msg":"trace[670414681] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24962; }","duration":"119.636321ms","start":"2026-06-10T09:01:42.413786Z","end":"2026-06-10T09:01:42.533423Z","steps":["trace[670414681] 'range keys from in-memory index tree' (duration: 119.346267ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T09:01:42.880842Z","caller":"traceutil/trace.go:171","msg":"trace[969576275] transaction","detail":"{read_only:false; response_revision:24965; number_of_response:1; }","duration":"138.363196ms","start":"2026-06-10T09:01:42.742455Z","end":"2026-06-10T09:01:42.880818Z","steps":["trace[969576275] 'process raft request' (duration: 138.215632ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T09:01:43.159932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.252441ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-10T09:01:43.16029Z","caller":"traceutil/trace.go:171","msg":"trace[1063188755] transaction","detail":"{read_only:false; response_revision:24968; number_of_response:1; }","duration":"274.582911ms","start":"2026-06-10T09:01:42.885677Z","end":"2026-06-10T09:01:43.16026Z","steps":["trace[1063188755] 'process raft request' (duration: 274.52672ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T09:01:43.160465Z","caller":"traceutil/trace.go:171","msg":"trace[37065855] transaction","detail":"{read_only:false; response_revision:24966; number_of_response:1; }","duration":"333.846201ms","start":"2026-06-10T09:01:42.82659Z","end":"2026-06-10T09:01:43.160436Z","steps":["trace[37065855] 'process raft request' (duration: 192.981219ms)","trace[37065855] 'compare' (duration: 139.909015ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T09:01:43.160577Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T09:01:42.826567Z","time spent":"333.958213ms","remote":"127.0.0.1:54942","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":498,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T09:01:43.160611Z","caller":"traceutil/trace.go:171","msg":"trace[2119641314] transaction","detail":"{read_only:false; response_revision:24967; number_of_response:1; }","duration":"301.49909ms","start":"2026-06-10T09:01:42.859099Z","end":"2026-06-10T09:01:43.160598Z","steps":["trace[2119641314] 'process raft request' (duration: 300.95339ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T09:01:43.160583Z","caller":"traceutil/trace.go:171","msg":"trace[1392557326] linearizableReadLoop","detail":"{readStateIndex:25774; appliedIndex:25772; }","duration":"279.31599ms","start":"2026-06-10T09:01:42.881223Z","end":"2026-06-10T09:01:43.160539Z","steps":["trace[1392557326] 'read index received' (duration: 138.353696ms)","trace[1392557326] 'applied index is now lower than readState.Index' (duration: 140.957064ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T09:01:43.160699Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T09:01:42.859066Z","time spent":"301.579171ms","remote":"127.0.0.1:54942","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T09:01:43.160809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.043398ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-10T09:01:43.16085Z","caller":"traceutil/trace.go:171","msg":"trace[2093492933] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24968; }","duration":"369.13607ms","start":"2026-06-10T09:01:42.791702Z","end":"2026-06-10T09:01:43.160838Z","steps":["trace[2093492933] 'agreement among raft nodes before linearized reading' (duration: 368.974356ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T09:01:43.160886Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T09:01:42.79168Z","time spent":"369.19948ms","remote":"127.0.0.1:54942","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-10T09:01:43.16097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.581297ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"warn","ts":"2026-06-10T09:01:43.160992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.836257ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/thanosrulers/\" range_end:\"/registry/monitoring.coreos.com/thanosrulers0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T09:01:43.161041Z","caller":"traceutil/trace.go:171","msg":"trace[741348162] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24968; }","duration":"369.678699ms","start":"2026-06-10T09:01:42.791346Z","end":"2026-06-10T09:01:43.161024Z","steps":["trace[741348162] 'agreement among raft nodes before linearized reading' (duration: 369.434065ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T09:01:43.161056Z","caller":"traceutil/trace.go:171","msg":"trace[254415036] range","detail":"{range_begin:/registry/monitoring.coreos.com/thanosrulers/; range_end:/registry/monitoring.coreos.com/thanosrulers0; response_count:0; response_revision:24968; }","duration":"274.974429ms","start":"2026-06-10T09:01:42.886057Z","end":"2026-06-10T09:01:43.161031Z","steps":["trace[254415036] 'agreement among raft nodes before linearized reading' (duration: 274.786206ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T09:01:43.161084Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T09:01:42.791341Z","time spent":"369.73592ms","remote":"127.0.0.1:54942","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":464,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-10T09:01:43.467917Z","caller":"traceutil/trace.go:171","msg":"trace[1461301468] linearizableReadLoop","detail":"{readStateIndex:25777; appliedIndex:25776; }","duration":"247.618661ms","start":"2026-06-10T09:01:43.220274Z","end":"2026-06-10T09:01:43.467892Z","steps":["trace[1461301468] 'read index received' (duration: 247.408267ms)","trace[1461301468] 'applied index is now lower than readState.Index' (duration: 209.584µs)"],"step_count":2} {"level":"warn","ts":"2026-06-10T09:01:43.468108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.789644ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigs/\" range_end:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigs0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T09:01:43.468148Z","caller":"traceutil/trace.go:171","msg":"trace[847006241] range","detail":"{range_begin:/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigs/; range_end:/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigs0; response_count:0; response_revision:24970; }","duration":"247.906997ms","start":"2026-06-10T09:01:43.220226Z","end":"2026-06-10T09:01:43.468133Z","steps":["trace[847006241] 'agreement among raft nodes before linearized reading' (duration: 247.773164ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T09:01:43.468212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.784069ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T09:01:43.468246Z","caller":"traceutil/trace.go:171","msg":"trace[2039441514] transaction","detail":"{read_only:false; response_revision:24970; number_of_response:1; }","duration":"301.249945ms","start":"2026-06-10T09:01:43.16678Z","end":"2026-06-10T09:01:43.46803Z","steps":["trace[2039441514] 'process raft request' (duration: 300.97005ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T09:01:43.468361Z","caller":"traceutil/trace.go:171","msg":"trace[1340558577] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24970; }","duration":"189.020324ms","start":"2026-06-10T09:01:43.279291Z","end":"2026-06-10T09:01:43.468312Z","steps":["trace[1340558577] 'agreement among raft nodes before linearized reading' (duration: 188.7999ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T09:01:43.468503Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T09:01:43.166771Z","time spent":"301.591732ms","remote":"127.0.0.1:54942","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T09:01:44.46829Z","caller":"traceutil/trace.go:171","msg":"trace[532841182] transaction","detail":"{read_only:false; response_revision:24975; number_of_response:1; }","duration":"263.792746ms","start":"2026-06-10T09:01:44.204468Z","end":"2026-06-10T09:01:44.46826Z","steps":["trace[532841182] 'process raft request' (duration: 263.594613ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T09:01:44.480376Z","caller":"traceutil/trace.go:171","msg":"trace[1803524169] linearizableReadLoop","detail":"{readStateIndex:25783; appliedIndex:25781; }","duration":"199.720327ms","start":"2026-06-10T09:01:44.280578Z","end":"2026-06-10T09:01:44.480298Z","steps":["trace[1803524169] 'read index received' (duration: 187.490705ms)","trace[1803524169] 'applied index is now lower than readState.Index' (duration: 12.227591ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T09:01:44.480479Z","caller":"traceutil/trace.go:171","msg":"trace[421635657] transaction","detail":"{read_only:false; response_revision:24976; number_of_response:1; }","duration":"268.795441ms","start":"2026-06-10T09:01:44.211648Z","end":"2026-06-10T09:01:44.480443Z","steps":["trace[421635657] 'process raft request' (duration: 268.468985ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T09:01:44.480535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.92939ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T09:01:44.480568Z","caller":"traceutil/trace.go:171","msg":"trace[703304804] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24976; }","duration":"200.035372ms","start":"2026-06-10T09:01:44.28052Z","end":"2026-06-10T09:01:44.480556Z","steps":["trace[703304804] 'agreement among raft nodes before linearized reading' (duration: 199.943681ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T09:01:44.621339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.119296ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rook-ceph-pdbstatemap\" ","response":"range_response_count:1 size:357"} {"level":"info","ts":"2026-06-10T09:01:44.62144Z","caller":"traceutil/trace.go:171","msg":"trace[1467317644] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-pdbstatemap; range_end:; response_count:1; response_revision:24976; }","duration":"125.278319ms","start":"2026-06-10T09:01:44.496138Z","end":"2026-06-10T09:01:44.621416Z","steps":["trace[1467317644] 'range keys from in-memory index tree' (duration: 124.920062ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T09:01:44.745561Z","caller":"traceutil/trace.go:171","msg":"trace[1932370720] transaction","detail":"{read_only:false; response_revision:24978; number_of_response:1; }","duration":"109.604271ms","start":"2026-06-10T09:01:44.635917Z","end":"2026-06-10T09:01:44.745521Z","steps":["trace[1932370720] 'process raft request' (duration: 105.887412ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T09:01:45.069245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.6373ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-10T09:01:45.069367Z","caller":"traceutil/trace.go:171","msg":"trace[1793066798] linearizableReadLoop","detail":"{readStateIndex:25786; appliedIndex:25785; }","duration":"180.35797ms","start":"2026-06-10T09:01:44.888988Z","end":"2026-06-10T09:01:45.069346Z","steps":["trace[1793066798] 'read index received' (duration: 22.481395ms)","trace[1793066798] 'applied index is now lower than readState.Index' (duration: 157.874695ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T09:01:45.069437Z","caller":"traceutil/trace.go:171","msg":"trace[586627817] transaction","detail":"{read_only:false; response_revision:24979; number_of_response:1; }","duration":"212.680251ms","start":"2026-06-10T09:01:44.856706Z","end":"2026-06-10T09:01:45.069387Z","steps":["trace[586627817] 'process raft request' (duration: 54.784556ms)","trace[586627817] 'compare' (duration: 157.346174ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T09:01:45.069797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.804258ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-06-10T09:01:45.069845Z","caller":"traceutil/trace.go:171","msg":"trace[1211645581] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24979; }","duration":"180.89471ms","start":"2026-06-10T09:01:44.888937Z","end":"2026-06-10T09:01:45.069832Z","steps":["trace[1211645581] 'agreement among raft nodes before linearized reading' (duration: 180.466872ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T09:01:45.22414Z","caller":"traceutil/trace.go:171","msg":"trace[1960129324] transaction","detail":"{read_only:false; response_revision:24980; number_of_response:1; }","duration":"149.353833ms","start":"2026-06-10T09:01:45.074766Z","end":"2026-06-10T09:01:45.22412Z","steps":["trace[1960129324] 'process raft request' (duration: 149.086288ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T09:01:45.705874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.425903ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-06-10T09:01:45.706253Z","caller":"traceutil/trace.go:171","msg":"trace[911117369] transaction","detail":"{read_only:false; response_revision:24984; number_of_response:1; }","duration":"146.390088ms","start":"2026-06-10T09:01:45.559809Z","end":"2026-06-10T09:01:45.706199Z","steps":["trace[911117369] 'process raft request' (duration: 146.176964ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T09:01:45.78575Z","caller":"traceutil/trace.go:171","msg":"trace[1394015118] transaction","detail":"{read_only:false; response_revision:24985; number_of_response:1; }","duration":"123.161498ms","start":"2026-06-10T09:01:45.662568Z","end":"2026-06-10T09:01:45.785729Z","steps":["trace[1394015118] 'process raft request' (duration: 45.155644ms)","trace[1394015118] 'compare' (duration: 77.887662ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T09:01:46.029636Z","caller":"traceutil/trace.go:171","msg":"trace[401207762] transaction","detail":"{read_only:false; response_revision:24986; number_of_response:1; }","duration":"366.926567ms","start":"2026-06-10T09:01:45.662665Z","end":"2026-06-10T09:01:46.029591Z","steps":["trace[401207762] 'process raft request' (duration: 340.565549ms)","trace[401207762] 'compare' (duration: 26.233195ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T09:01:46.029806Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T09:01:45.662622Z","time spent":"367.097471ms","remote":"127.0.0.1:54942","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T09:01:46.764539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.748219ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-10T09:01:46.764699Z","caller":"traceutil/trace.go:171","msg":"trace[1933941455] transaction","detail":"{read_only:false; response_revision:24990; number_of_response:1; }","duration":"278.76125ms","start":"2026-06-10T09:01:46.485913Z","end":"2026-06-10T09:01:46.764674Z","steps":["trace[1933941455] 'process raft request' (duration: 136.716495ms)","trace[1933941455] 'compare' (duration: 141.332442ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T09:01:46.971313Z","caller":"traceutil/trace.go:171","msg":"trace[1736853514] linearizableReadLoop","detail":"{readStateIndex:25799; appliedIndex:25798; }","duration":"220.394467ms","start":"2026-06-10T09:01:46.750779Z","end":"2026-06-10T09:01:46.971174Z","steps":["trace[1736853514] 'read index received' (duration: 203.851883ms)","trace[1736853514] 'applied index is now lower than readState.Index' (duration: 16.538893ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T09:01:46.9717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.890985ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-06-10T09:01:46.971775Z","caller":"traceutil/trace.go:171","msg":"trace[1834760555] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24991; }","duration":"221.018908ms","start":"2026-06-10T09:01:46.750717Z","end":"2026-06-10T09:01:46.971735Z","steps":["trace[1834760555] 'agreement among raft nodes before linearized reading' (duration: 220.694012ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T09:01:46.972533Z","caller":"traceutil/trace.go:171","msg":"trace[826755951] transaction","detail":"{read_only:false; response_revision:24991; number_of_response:1; }","duration":"333.783491ms","start":"2026-06-10T09:01:46.638682Z","end":"2026-06-10T09:01:46.972465Z","steps":["trace[826755951] 'process raft request' (duration: 316.050275ms)","trace[826755951] 'compare' (duration: 15.394321ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T09:01:46.972731Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T09:01:46.638652Z","time spent":"333.975824ms","remote":"127.0.0.1:54942","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T09:01:56.450188Z","caller":"traceutil/trace.go:171","msg":"trace[915799856] transaction","detail":"{read_only:false; response_revision:25060; number_of_response:1; }","duration":"291.248006ms","start":"2026-06-10T09:01:56.158885Z","end":"2026-06-10T09:01:56.450133Z","steps":["trace[915799856] 'process raft request' (duration: 291.032413ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T09:01:56.46048Z","caller":"traceutil/trace.go:171","msg":"trace[299317680] linearizableReadLoop","detail":"{readStateIndex:25871; appliedIndex:25869; }","duration":"179.308679ms","start":"2026-06-10T09:01:56.281119Z","end":"2026-06-10T09:01:56.460428Z","steps":["trace[299317680] 'read index received' (duration: 168.845402ms)","trace[299317680] 'applied index is now lower than readState.Index' (duration: 10.462107ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T09:01:56.46071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.571056ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T09:01:56.460763Z","caller":"traceutil/trace.go:171","msg":"trace[472254297] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25061; }","duration":"179.697418ms","start":"2026-06-10T09:01:56.281049Z","end":"2026-06-10T09:01:56.460746Z","steps":["trace[472254297] 'agreement among raft nodes before linearized reading' (duration: 179.543414ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T09:01:56.461229Z","caller":"traceutil/trace.go:171","msg":"trace[51472488] transaction","detail":"{read_only:false; response_revision:25061; number_of_response:1; }","duration":"301.893058ms","start":"2026-06-10T09:01:56.159322Z","end":"2026-06-10T09:01:56.461215Z","steps":["trace[51472488] 'process raft request' (duration: 300.840638ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T09:01:56.461346Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T09:01:56.159313Z","time spent":"301.959149ms","remote":"127.0.0.1:54942","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":539,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T09:01:57.144515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.263128ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T09:01:57.144671Z","caller":"traceutil/trace.go:171","msg":"trace[2105180065] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:25061; }","duration":"317.428121ms","start":"2026-06-10T09:01:56.827216Z","end":"2026-06-10T09:01:57.144645Z","steps":["trace[2105180065] 'range keys from in-memory index tree' (duration: 317.247608ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T09:01:57.144671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.446027ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-10T09:01:57.144809Z","caller":"traceutil/trace.go:171","msg":"trace[1598440308] transaction","detail":"{read_only:false; response_revision:25062; number_of_response:1; }","duration":"615.306332ms","start":"2026-06-10T09:01:56.529473Z","end":"2026-06-10T09:01:57.144779Z","steps":["trace[1598440308] 'process raft request' (duration: 275.658951ms)","trace[1598440308] 'compare' (duration: 339.157872ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T09:01:57.144879Z","caller":"traceutil/trace.go:171","msg":"trace[1831081916] transaction","detail":"{read_only:false; response_revision:25063; number_of_response:1; }","duration":"321.997237ms","start":"2026-06-10T09:01:56.822866Z","end":"2026-06-10T09:01:57.144863Z","steps":["trace[1831081916] 'process raft request' (duration: 321.909306ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T09:01:57.144883Z","caller":"traceutil/trace.go:171","msg":"trace[1417587008] linearizableReadLoop","detail":"{readStateIndex:25872; appliedIndex:25871; }","duration":"336.199645ms","start":"2026-06-10T09:01:56.808671Z","end":"2026-06-10T09:01:57.14487Z","steps":["trace[1417587008] 'read index received' (duration: 50.431µs)","trace[1417587008] 'applied index is now lower than readState.Index' (duration: 336.148004ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T09:01:57.144941Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T09:01:56.822832Z","time spent":"322.085169ms","remote":"127.0.0.1:54942","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T09:01:57.144952Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T09:01:56.529449Z","time spent":"615.425234ms","remote":"127.0.0.1:54942","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T09:01:57.144978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.304317ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T09:01:57.14501Z","caller":"traceutil/trace.go:171","msg":"trace[316195414] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila; range_end:; response_count:0; response_revision:25063; }","duration":"336.374949ms","start":"2026-06-10T09:01:56.808621Z","end":"2026-06-10T09:01:57.144996Z","steps":["trace[316195414] 'agreement among raft nodes before linearized reading' (duration: 336.318938ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T09:01:57.14505Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T09:01:56.808596Z","time spent":"336.44624ms","remote":"127.0.0.1:46714","response type":"/etcdserverpb.KV/Range","request count":0,"request size":67,"response count":0,"response size":29,"request content":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila\" "} {"level":"warn","ts":"2026-06-10T09:01:57.157336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.632556ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-10T09:01:57.157426Z","caller":"traceutil/trace.go:171","msg":"trace[294212910] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:25064; }","duration":"316.786508ms","start":"2026-06-10T09:01:56.840619Z","end":"2026-06-10T09:01:57.157406Z","steps":["trace[294212910] 'agreement among raft nodes before linearized reading' (duration: 316.614395ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T09:01:57.157475Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T09:01:56.840592Z","time spent":"316.871799ms","remote":"127.0.0.1:55044","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":31,"request content":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true "} {"level":"info","ts":"2026-06-10T09:01:57.157506Z","caller":"traceutil/trace.go:171","msg":"trace[1474728078] transaction","detail":"{read_only:false; response_revision:25064; number_of_response:1; }","duration":"148.458517ms","start":"2026-06-10T09:01:57.009011Z","end":"2026-06-10T09:01:57.157469Z","steps":["trace[1474728078] 'process raft request' (duration: 148.057559ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T09:01:57.157862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.173235ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"info","ts":"2026-06-10T09:01:57.157909Z","caller":"traceutil/trace.go:171","msg":"trace[281292920] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25064; }","duration":"135.274998ms","start":"2026-06-10T09:01:57.022622Z","end":"2026-06-10T09:01:57.157897Z","steps":["trace[281292920] 'agreement among raft nodes before linearized reading' (duration: 135.122825ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T09:01:57.562905Z","caller":"traceutil/trace.go:171","msg":"trace[578299692] transaction","detail":"{read_only:false; response_revision:25068; number_of_response:1; }","duration":"347.786686ms","start":"2026-06-10T09:01:57.215081Z","end":"2026-06-10T09:01:57.562868Z","steps":["trace[578299692] 'process raft request' (duration: 266.000939ms)","trace[578299692] 'compare' (duration: 81.474331ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T09:01:57.56302Z","caller":"traceutil/trace.go:171","msg":"trace[1470390804] linearizableReadLoop","detail":"{readStateIndex:25878; appliedIndex:25877; }","duration":"290.751148ms","start":"2026-06-10T09:01:57.272239Z","end":"2026-06-10T09:01:57.56299Z","steps":["trace[1470390804] 'read index received' (duration: 208.858699ms)","trace[1470390804] 'applied index is now lower than readState.Index' (duration: 81.890009ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T09:01:57.563078Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T09:01:57.215051Z","time spent":"347.931569ms","remote":"127.0.0.1:46714","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1946,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T09:01:57.563221Z","caller":"traceutil/trace.go:171","msg":"trace[12325924] transaction","detail":"{read_only:false; response_revision:25069; number_of_response:1; }","duration":"288.723979ms","start":"2026-06-10T09:01:57.274478Z","end":"2026-06-10T09:01:57.563202Z","steps":["trace[12325924] 'process raft request' (duration: 288.311641ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T09:01:57.563353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.090584ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-06-10T09:01:57.563408Z","caller":"traceutil/trace.go:171","msg":"trace[1521018659] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25069; }","duration":"291.210326ms","start":"2026-06-10T09:01:57.272183Z","end":"2026-06-10T09:01:57.563393Z","steps":["trace[1521018659] 'agreement among raft nodes before linearized reading' (duration: 290.973962ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T09:01:57.563618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.722994ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12211"} {"level":"info","ts":"2026-06-10T09:01:57.563661Z","caller":"traceutil/trace.go:171","msg":"trace[913660364] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25069; }","duration":"137.768865ms","start":"2026-06-10T09:01:57.425883Z","end":"2026-06-10T09:01:57.563651Z","steps":["trace[913660364] 'agreement among raft nodes before linearized reading' (duration: 137.653403ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T09:01:57.563829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.56293ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-06-10T09:01:57.563778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.942118ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-06-10T09:01:57.563875Z","caller":"traceutil/trace.go:171","msg":"trace[2101259279] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25069; }","duration":"247.630841ms","start":"2026-06-10T09:01:57.316234Z","end":"2026-06-10T09:01:57.563865Z","steps":["trace[2101259279] 'agreement among raft nodes before linearized reading' (duration: 247.520579ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T09:01:57.563935Z","caller":"traceutil/trace.go:171","msg":"trace[132853404] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25069; }","duration":"248.153791ms","start":"2026-06-10T09:01:57.315739Z","end":"2026-06-10T09:01:57.563893Z","steps":["trace[132853404] 'agreement among raft nodes before linearized reading' (duration: 247.690223ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T09:01:57.806845Z","caller":"traceutil/trace.go:171","msg":"trace[1359915269] transaction","detail":"{read_only:false; response_revision:25070; number_of_response:1; }","duration":"237.926508ms","start":"2026-06-10T09:01:57.568872Z","end":"2026-06-10T09:01:57.806798Z","steps":["trace[1359915269] 'process raft request' (duration: 225.228488ms)","trace[1359915269] 'compare' (duration: 12.382885ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T09:01:58.371341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.606099ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-10T09:01:58.371664Z","caller":"traceutil/trace.go:171","msg":"trace[473885922] transaction","detail":"{read_only:false; response_revision:25071; number_of_response:1; }","duration":"802.610882ms","start":"2026-06-10T09:01:57.569017Z","end":"2026-06-10T09:01:58.371628Z","steps":["trace[473885922] 'process raft request' (duration: 553.566466ms)","trace[473885922] 'compare' (duration: 248.196361ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T09:01:58.371762Z","caller":"traceutil/trace.go:171","msg":"trace[580246017] transaction","detail":"{read_only:false; response_revision:25072; number_of_response:1; }","duration":"802.055551ms","start":"2026-06-10T09:01:57.569679Z","end":"2026-06-10T09:01:58.371734Z","steps":["trace[580246017] 'process raft request' (duration: 801.783586ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T09:01:58.37184Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T09:01:57.569001Z","time spent":"802.742565ms","remote":"127.0.0.1:54942","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T09:01:58.371832Z","caller":"traceutil/trace.go:171","msg":"trace[1370061452] transaction","detail":"{read_only:false; response_revision:25074; number_of_response:1; }","duration":"545.397571ms","start":"2026-06-10T09:01:57.82641Z","end":"2026-06-10T09:01:58.371808Z","steps":["trace[1370061452] 'process raft request' (duration: 545.273637ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T09:01:58.371951Z","caller":"traceutil/trace.go:171","msg":"trace[1849461979] transaction","detail":"{read_only:false; response_revision:25073; number_of_response:1; }","duration":"799.712559ms","start":"2026-06-10T09:01:57.572196Z","end":"2026-06-10T09:01:58.371908Z","steps":["trace[1849461979] 'process raft request' (duration: 799.393473ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T09:01:58.372019Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T09:01:57.82638Z","time spent":"545.553833ms","remote":"127.0.0.1:54942","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":608,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T09:01:58.372149Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T09:01:57.572185Z","time spent":"799.857462ms","remote":"127.0.0.1:46714","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2793,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T09:01:58.372546Z","caller":"traceutil/trace.go:171","msg":"trace[1283432458] linearizableReadLoop","detail":"{readStateIndex:25882; appliedIndex:25879; }","duration":"802.487641ms","start":"2026-06-10T09:01:57.569984Z","end":"2026-06-10T09:01:58.372472Z","steps":["trace[1283432458] 'read index received' (duration: 224.080217ms)","trace[1283432458] 'applied index is now lower than readState.Index' (duration: 578.404564ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T09:01:58.371892Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T09:01:57.56967Z","time spent":"802.150715ms","remote":"127.0.0.1:54942","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T09:01:58.37289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"802.895138ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:18744"} {"level":"info","ts":"2026-06-10T09:01:58.372963Z","caller":"traceutil/trace.go:171","msg":"trace[687441460] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:25074; }","duration":"802.956209ms","start":"2026-06-10T09:01:57.569966Z","end":"2026-06-10T09:01:58.372922Z","steps":["trace[687441460] 'agreement among raft nodes before linearized reading' (duration: 802.687264ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T09:01:58.373043Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T09:01:57.56996Z","time spent":"803.069131ms","remote":"127.0.0.1:54860","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":18767,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-06-10T09:01:58.992366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"489.436854ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-10T09:01:58.99274Z","caller":"traceutil/trace.go:171","msg":"trace[200829296] linearizableReadLoop","detail":"{readStateIndex:25885; appliedIndex:25884; }","duration":"620.133004ms","start":"2026-06-10T09:01:58.372589Z","end":"2026-06-10T09:01:58.992722Z","steps":["trace[200829296] 'read index received' (duration: 130.279973ms)","trace[200829296] 'applied index is now lower than readState.Index' (duration: 489.851331ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T09:01:58.992838Z","caller":"traceutil/trace.go:171","msg":"trace[1934890435] transaction","detail":"{read_only:false; response_revision:25075; number_of_response:1; }","duration":"848.037822ms","start":"2026-06-10T09:01:58.144787Z","end":"2026-06-10T09:01:58.992825Z","steps":["trace[1934890435] 'process raft request' (duration: 358.039728ms)","trace[1934890435] 'compare' (duration: 489.040886ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T09:01:58.992884Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T09:01:58.144768Z","time spent":"848.091174ms","remote":"127.0.0.1:54942","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T09:01:58.992988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"854.88136ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/schemareplications/\" range_end:\"/registry/rabbitmq.com/schemareplications0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-10T09:01:58.992997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"711.249367ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-10T09:01:58.993006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"889.436335ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/machinedeployments/\" range_end:\"/registry/cluster.x-k8s.io/machinedeployments0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T09:01:58.993057Z","caller":"traceutil/trace.go:171","msg":"trace[429238464] range","detail":"{range_begin:/registry/rabbitmq.com/schemareplications/; range_end:/registry/rabbitmq.com/schemareplications0; response_count:0; response_revision:25076; }","duration":"855.017753ms","start":"2026-06-10T09:01:58.138021Z","end":"2026-06-10T09:01:58.993039Z","steps":["trace[429238464] 'agreement among raft nodes before linearized reading' (duration: 854.85763ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T09:01:58.993018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"779.615658ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/superstreams/\" range_end:\"/registry/rabbitmq.com/superstreams0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-10T09:01:58.993054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.208958745s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"warn","ts":"2026-06-10T09:01:58.993093Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T09:01:58.137995Z","time spent":"855.090435ms","remote":"127.0.0.1:46718","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":29,"request content":"key:\"/registry/rabbitmq.com/schemareplications/\" range_end:\"/registry/rabbitmq.com/schemareplications0\" count_only:true "} {"level":"info","ts":"2026-06-10T09:01:58.993089Z","caller":"traceutil/trace.go:171","msg":"trace[411772599] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25076; }","duration":"711.43585ms","start":"2026-06-10T09:01:58.281632Z","end":"2026-06-10T09:01:58.993067Z","steps":["trace[411772599] 'agreement among raft nodes before linearized reading' (duration: 711.262237ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T09:01:58.993104Z","caller":"traceutil/trace.go:171","msg":"trace[1824304374] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machinedeployments/; range_end:/registry/cluster.x-k8s.io/machinedeployments0; response_count:0; response_revision:25076; }","duration":"889.591298ms","start":"2026-06-10T09:01:58.103484Z","end":"2026-06-10T09:01:58.993076Z","steps":["trace[1824304374] 'agreement among raft nodes before linearized reading' (duration: 889.352203ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T09:01:58.993121Z","caller":"traceutil/trace.go:171","msg":"trace[1632157898] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25076; }","duration":"1.209083567s","start":"2026-06-10T09:01:57.784018Z","end":"2026-06-10T09:01:58.993102Z","steps":["trace[1632157898] 'agreement among raft nodes before linearized reading' (duration: 1.208842943s)"],"step_count":1} {"level":"info","ts":"2026-06-10T09:01:58.993116Z","caller":"traceutil/trace.go:171","msg":"trace[1514405149] range","detail":"{range_begin:/registry/rabbitmq.com/superstreams/; range_end:/registry/rabbitmq.com/superstreams0; response_count:0; response_revision:25076; }","duration":"779.781442ms","start":"2026-06-10T09:01:58.21331Z","end":"2026-06-10T09:01:58.993091Z","steps":["trace[1514405149] 'agreement among raft nodes before linearized reading' (duration: 779.566688ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T09:01:58.993123Z","caller":"traceutil/trace.go:171","msg":"trace[1470937704] transaction","detail":"{read_only:false; response_revision:25076; number_of_response:1; }","duration":"536.613315ms","start":"2026-06-10T09:01:58.456501Z","end":"2026-06-10T09:01:58.993115Z","steps":["trace[1470937704] 'process raft request' (duration: 535.960533ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T09:01:58.993143Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T09:01:58.281599Z","time spent":"711.534972ms","remote":"127.0.0.1:54722","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-10T09:01:58.993152Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T09:01:57.783982Z","time spent":"1.209164399s","remote":"127.0.0.1:54942","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":464,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-10T09:01:58.993152Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T09:01:58.103456Z","time spent":"889.683919ms","remote":"127.0.0.1:35678","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":29,"request content":"key:\"/registry/cluster.x-k8s.io/machinedeployments/\" range_end:\"/registry/cluster.x-k8s.io/machinedeployments0\" count_only:true "} {"level":"warn","ts":"2026-06-10T09:01:58.993117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"620.190695ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates/\" range_end:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-10T09:01:58.993151Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.262547ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackservers/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackservers0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-10T09:01:58.993231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"615.648718ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/openstack/rabbitmq-manila-default-user\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T09:01:58.993225Z","caller":"traceutil/trace.go:171","msg":"trace[214512328] range","detail":"{range_begin:/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates/; range_end:/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates0; response_count:0; response_revision:25077; }","duration":"620.348788ms","start":"2026-06-10T09:01:58.372851Z","end":"2026-06-10T09:01:58.9932Z","steps":["trace[214512328] 'agreement among raft nodes before linearized reading' (duration: 620.141644ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T09:01:58.993249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.255593ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-10T09:01:58.993239Z","caller":"traceutil/trace.go:171","msg":"trace[1891688561] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackservers/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackservers0; response_count:0; response_revision:25077; }","duration":"117.454971ms","start":"2026-06-10T09:01:58.875764Z","end":"2026-06-10T09:01:58.993219Z","steps":["trace[1891688561] 'agreement among raft nodes before linearized reading' (duration: 117.232167ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T09:01:58.99326Z","caller":"traceutil/trace.go:171","msg":"trace[1867999975] transaction","detail":"{read_only:false; response_revision:25077; number_of_response:1; }","duration":"525.276961ms","start":"2026-06-10T09:01:58.467974Z","end":"2026-06-10T09:01:58.993251Z","steps":["trace[1867999975] 'process raft request' (duration: 524.801912ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T09:01:58.993257Z","caller":"traceutil/trace.go:171","msg":"trace[1420226928] range","detail":"{range_begin:/registry/secrets/openstack/rabbitmq-manila-default-user; range_end:; response_count:0; response_revision:25077; }","duration":"615.69566ms","start":"2026-06-10T09:01:58.377553Z","end":"2026-06-10T09:01:58.993249Z","steps":["trace[1420226928] 'agreement among raft nodes before linearized reading' (duration: 615.644309ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T09:01:58.99328Z","caller":"traceutil/trace.go:171","msg":"trace[128201839] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:25077; }","duration":"331.337253ms","start":"2026-06-10T09:01:58.661934Z","end":"2026-06-10T09:01:58.993271Z","steps":["trace[128201839] 'agreement among raft nodes before linearized reading' (duration: 331.266702ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T09:01:58.993266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"550.777883ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-10T09:01:58.993301Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T09:01:58.661907Z","time spent":"331.389975ms","remote":"127.0.0.1:54810","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":19,"response size":31,"request content":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true "} {"level":"warn","ts":"2026-06-10T09:01:58.993286Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T09:01:58.372831Z","time spent":"620.44335ms","remote":"127.0.0.1:36004","response type":"/etcdserverpb.KV/Range","request count":0,"request size":126,"response count":0,"response size":29,"request content":"key:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates/\" range_end:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates0\" count_only:true "} {"level":"warn","ts":"2026-06-10T09:01:58.993328Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T09:01:58.467963Z","time spent":"525.319771ms","remote":"127.0.0.1:54942","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T09:01:58.993289Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T09:01:58.377532Z","time spent":"615.75204ms","remote":"127.0.0.1:54796","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":0,"response size":29,"request content":"key:\"/registry/secrets/openstack/rabbitmq-manila-default-user\" "} {"level":"info","ts":"2026-06-10T09:01:58.993332Z","caller":"traceutil/trace.go:171","msg":"trace[2075810] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:25077; }","duration":"550.896095ms","start":"2026-06-10T09:01:58.44242Z","end":"2026-06-10T09:01:58.993316Z","steps":["trace[2075810] 'agreement among raft nodes before linearized reading' (duration: 550.752242ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T09:01:58.993374Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T09:01:58.442397Z","time spent":"550.967186ms","remote":"127.0.0.1:55130","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":29,"request content":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" "} {"level":"warn","ts":"2026-06-10T09:01:58.993173Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T09:01:58.456482Z","time spent":"536.668716ms","remote":"127.0.0.1:54942","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T09:01:58.993166Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T09:01:58.213296Z","time spent":"779.863103ms","remote":"127.0.0.1:46692","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":29,"request content":"key:\"/registry/rabbitmq.com/superstreams/\" range_end:\"/registry/rabbitmq.com/superstreams0\" count_only:true "} {"level":"info","ts":"2026-06-10T09:01:59.16237Z","caller":"traceutil/trace.go:171","msg":"trace[1961800147] transaction","detail":"{read_only:false; response_revision:25078; number_of_response:1; }","duration":"164.398558ms","start":"2026-06-10T09:01:58.997947Z","end":"2026-06-10T09:01:59.162346Z","steps":["trace[1961800147] 'process raft request' (duration: 161.097456ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T09:01:59.162525Z","caller":"traceutil/trace.go:171","msg":"trace[381089667] linearizableReadLoop","detail":"{readStateIndex:25888; appliedIndex:25887; }","duration":"163.632464ms","start":"2026-06-10T09:01:58.998885Z","end":"2026-06-10T09:01:59.162518Z","steps":["trace[381089667] 'read index received' (duration: 160.203979ms)","trace[381089667] 'applied index is now lower than readState.Index' (duration: 3.427315ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T09:01:59.162624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.714105ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/openstack/\" range_end:\"/registry/resourcequotas/openstack0\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T09:01:59.162657Z","caller":"traceutil/trace.go:171","msg":"trace[1694593262] range","detail":"{range_begin:/registry/resourcequotas/openstack/; range_end:/registry/resourcequotas/openstack0; response_count:0; response_revision:25080; }","duration":"163.773846ms","start":"2026-06-10T09:01:58.998873Z","end":"2026-06-10T09:01:59.162646Z","steps":["trace[1694593262] 'agreement among raft nodes before linearized reading' (duration: 163.694755ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T09:01:59.166367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.398956ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12211"} {"level":"info","ts":"2026-06-10T09:01:59.166443Z","caller":"traceutil/trace.go:171","msg":"trace[1765583518] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25081; }","duration":"167.499327ms","start":"2026-06-10T09:01:58.998924Z","end":"2026-06-10T09:01:59.166423Z","steps":["trace[1765583518] 'agreement among raft nodes before linearized reading' (duration: 167.237142ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T09:02:00.483537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.160497ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-cc1f1459-71e1-4d39-9433-fc9779a0d67e\" ","response":"range_response_count:1 size:3642"} {"level":"info","ts":"2026-06-10T09:02:00.483638Z","caller":"traceutil/trace.go:171","msg":"trace[1750633174] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-cc1f1459-71e1-4d39-9433-fc9779a0d67e; range_end:; response_count:1; response_revision:25146; }","duration":"133.324461ms","start":"2026-06-10T09:02:00.350289Z","end":"2026-06-10T09:02:00.483614Z","steps":["trace[1750633174] 'range keys from in-memory index tree' (duration: 132.953074ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T09:02:00.483749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.201467ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-06-10T09:02:00.483756Z","caller":"traceutil/trace.go:171","msg":"trace[830811468] transaction","detail":"{read_only:false; response_revision:25147; number_of_response:1; }","duration":"105.076196ms","start":"2026-06-10T09:02:00.378625Z","end":"2026-06-10T09:02:00.483701Z","steps":["trace[830811468] 'process raft request' (duration: 74.215163ms)","trace[830811468] 'compare' (duration: 30.409645ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T09:02:00.48384Z","caller":"traceutil/trace.go:171","msg":"trace[1230828981] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25146; }","duration":"106.35727ms","start":"2026-06-10T09:02:00.377462Z","end":"2026-06-10T09:02:00.483819Z","steps":["trace[1230828981] 'range keys from in-memory index tree' (duration: 105.76027ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T09:02:00.483852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.076294ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-10T09:02:00.48395Z","caller":"traceutil/trace.go:171","msg":"trace[2072327689] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25146; }","duration":"107.233017ms","start":"2026-06-10T09:02:00.376696Z","end":"2026-06-10T09:02:00.483929Z","steps":["trace[2072327689] 'range keys from in-memory index tree' (duration: 106.472643ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T09:02:02.264934Z","caller":"traceutil/trace.go:171","msg":"trace[1289885000] linearizableReadLoop","detail":"{readStateIndex:25972; appliedIndex:25971; }","duration":"133.860521ms","start":"2026-06-10T09:02:02.131043Z","end":"2026-06-10T09:02:02.264904Z","steps":["trace[1289885000] 'read index received' (duration: 133.618716ms)","trace[1289885000] 'applied index is now lower than readState.Index' (duration: 239.835µs)"],"step_count":2} {"level":"info","ts":"2026-06-10T09:02:02.265049Z","caller":"traceutil/trace.go:171","msg":"trace[149971722] transaction","detail":"{read_only:false; response_revision:25161; number_of_response:1; }","duration":"156.245593ms","start":"2026-06-10T09:02:02.108767Z","end":"2026-06-10T09:02:02.265012Z","steps":["trace[149971722] 'process raft request' (duration: 155.937037ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T09:02:02.265084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.035184ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T09:02:02.265146Z","caller":"traceutil/trace.go:171","msg":"trace[1331093867] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25161; }","duration":"134.141936ms","start":"2026-06-10T09:02:02.130989Z","end":"2026-06-10T09:02:02.265131Z","steps":["trace[1331093867] 'agreement among raft nodes before linearized reading' (duration: 134.023794ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T09:02:07.168802Z","caller":"traceutil/trace.go:171","msg":"trace[1366016412] transaction","detail":"{read_only:false; response_revision:25216; number_of_response:1; }","duration":"146.151663ms","start":"2026-06-10T09:02:07.022608Z","end":"2026-06-10T09:02:07.168759Z","steps":["trace[1366016412] 'process raft request' (duration: 145.362768ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T09:02:07.168903Z","caller":"traceutil/trace.go:171","msg":"trace[143559762] transaction","detail":"{read_only:false; response_revision:25217; number_of_response:1; }","duration":"145.764737ms","start":"2026-06-10T09:02:07.023109Z","end":"2026-06-10T09:02:07.168873Z","steps":["trace[143559762] 'process raft request' (duration: 145.197935ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T09:02:07.440575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.095584ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-10T09:02:07.440919Z","caller":"traceutil/trace.go:171","msg":"trace[552906405] transaction","detail":"{read_only:false; response_revision:25218; number_of_response:1; }","duration":"250.594948ms","start":"2026-06-10T09:02:07.19029Z","end":"2026-06-10T09:02:07.440885Z","steps":["trace[552906405] 'process raft request' (duration: 124.078905ms)","trace[552906405] 'compare' (duration: 125.696317ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T09:02:07.440982Z","caller":"traceutil/trace.go:171","msg":"trace[632843393] linearizableReadLoop","detail":"{readStateIndex:26033; appliedIndex:26030; }","duration":"245.799727ms","start":"2026-06-10T09:02:07.195165Z","end":"2026-06-10T09:02:07.440965Z","steps":["trace[632843393] 'read index received' (duration: 119.218634ms)","trace[632843393] 'applied index is now lower than readState.Index' (duration: 126.579793ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T09:02:07.441199Z","caller":"traceutil/trace.go:171","msg":"trace[553722312] transaction","detail":"{read_only:false; response_revision:25219; number_of_response:1; }","duration":"249.026868ms","start":"2026-06-10T09:02:07.19216Z","end":"2026-06-10T09:02:07.441187Z","steps":["trace[553722312] 'process raft request' (duration: 248.55959ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T09:02:07.441415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.43669ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"info","ts":"2026-06-10T09:02:07.44147Z","caller":"traceutil/trace.go:171","msg":"trace[2113245206] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25221; }","duration":"190.517931ms","start":"2026-06-10T09:02:07.250941Z","end":"2026-06-10T09:02:07.441459Z","steps":["trace[2113245206] 'agreement among raft nodes before linearized reading' (duration: 190.369559ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T09:02:07.441749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.185071ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila\" ","response":"range_response_count:1 size:3309"} {"level":"info","ts":"2026-06-10T09:02:07.441774Z","caller":"traceutil/trace.go:171","msg":"trace[320830079] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila; range_end:; response_count:1; response_revision:25221; }","duration":"158.271652ms","start":"2026-06-10T09:02:07.283496Z","end":"2026-06-10T09:02:07.441768Z","steps":["trace[320830079] 'agreement among raft nodes before linearized reading' (duration: 158.16845ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T09:02:07.441941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.656888ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T09:02:07.441966Z","caller":"traceutil/trace.go:171","msg":"trace[1170395454] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25221; }","duration":"160.707478ms","start":"2026-06-10T09:02:07.281252Z","end":"2026-06-10T09:02:07.44196Z","steps":["trace[1170395454] 'agreement among raft nodes before linearized reading' (duration: 160.662688ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T09:02:07.442462Z","caller":"traceutil/trace.go:171","msg":"trace[991455200] transaction","detail":"{read_only:false; response_revision:25221; number_of_response:1; }","duration":"166.718982ms","start":"2026-06-10T09:02:07.275724Z","end":"2026-06-10T09:02:07.442443Z","steps":["trace[991455200] 'process raft request' (duration: 165.196244ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T09:02:07.442658Z","caller":"traceutil/trace.go:171","msg":"trace[570739617] transaction","detail":"{read_only:false; response_revision:25220; number_of_response:1; }","duration":"250.187551ms","start":"2026-06-10T09:02:07.192324Z","end":"2026-06-10T09:02:07.442511Z","steps":["trace[570739617] 'process raft request' (duration: 248.55075ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T09:02:07.442762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.56923ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-06-10T09:02:07.442857Z","caller":"traceutil/trace.go:171","msg":"trace[1698597660] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25221; }","duration":"247.711093ms","start":"2026-06-10T09:02:07.195124Z","end":"2026-06-10T09:02:07.442835Z","steps":["trace[1698597660] 'agreement among raft nodes before linearized reading' (duration: 247.417388ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T09:02:07.613501Z","caller":"traceutil/trace.go:171","msg":"trace[42628853] transaction","detail":"{read_only:false; response_revision:25222; number_of_response:1; }","duration":"166.504868ms","start":"2026-06-10T09:02:07.446971Z","end":"2026-06-10T09:02:07.613476Z","steps":["trace[42628853] 'process raft request' (duration: 164.174993ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T09:02:07.613926Z","caller":"traceutil/trace.go:171","msg":"trace[1825979371] transaction","detail":"{read_only:false; response_revision:25223; number_of_response:1; }","duration":"166.443807ms","start":"2026-06-10T09:02:07.447448Z","end":"2026-06-10T09:02:07.613892Z","steps":["trace[1825979371] 'process raft request' (duration: 166.211293ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T09:02:15.911158Z","caller":"traceutil/trace.go:171","msg":"trace[432967240] linearizableReadLoop","detail":"{readStateIndex:26106; appliedIndex:26105; }","duration":"258.588988ms","start":"2026-06-10T09:02:15.652542Z","end":"2026-06-10T09:02:15.911131Z","steps":["trace[432967240] 'read index received' (duration: 258.374484ms)","trace[432967240] 'applied index is now lower than readState.Index' (duration: 213.124µs)"],"step_count":2} {"level":"info","ts":"2026-06-10T09:02:15.911317Z","caller":"traceutil/trace.go:171","msg":"trace[1905621068] transaction","detail":"{read_only:false; response_revision:25291; number_of_response:1; }","duration":"264.560062ms","start":"2026-06-10T09:02:15.646714Z","end":"2026-06-10T09:02:15.911274Z","steps":["trace[1905621068] 'process raft request' (duration: 264.200895ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T09:02:15.911424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.879574ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"info","ts":"2026-06-10T09:02:15.911484Z","caller":"traceutil/trace.go:171","msg":"trace[812241857] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25291; }","duration":"259.037127ms","start":"2026-06-10T09:02:15.652431Z","end":"2026-06-10T09:02:15.911468Z","steps":["trace[812241857] 'agreement among raft nodes before linearized reading' (duration: 258.860784ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T09:02:15.911599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.558144ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-06-10T09:02:15.911671Z","caller":"traceutil/trace.go:171","msg":"trace[872820782] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25291; }","duration":"254.704446ms","start":"2026-06-10T09:02:15.656947Z","end":"2026-06-10T09:02:15.911652Z","steps":["trace[872820782] 'agreement among raft nodes before linearized reading' (duration: 254.473862ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T09:02:16.097559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.078318ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-10T09:02:16.097937Z","caller":"traceutil/trace.go:171","msg":"trace[500451947] transaction","detail":"{read_only:false; response_revision:25294; number_of_response:1; }","duration":"179.811551ms","start":"2026-06-10T09:02:15.918099Z","end":"2026-06-10T09:02:16.09791Z","steps":["trace[500451947] 'process raft request' (duration: 179.730279ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T09:02:16.097963Z","caller":"traceutil/trace.go:171","msg":"trace[1191609987] transaction","detail":"{read_only:false; response_revision:25293; number_of_response:1; }","duration":"181.911819ms","start":"2026-06-10T09:02:15.916028Z","end":"2026-06-10T09:02:16.09794Z","steps":["trace[1191609987] 'process raft request' (duration: 181.679185ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T09:02:16.097939Z","caller":"traceutil/trace.go:171","msg":"trace[812057236] transaction","detail":"{read_only:false; response_revision:25292; number_of_response:1; }","duration":"181.9356ms","start":"2026-06-10T09:02:15.915935Z","end":"2026-06-10T09:02:16.09787Z","steps":["trace[812057236] 'process raft request' (duration: 13.418503ms)","trace[812057236] 'compare' (duration: 167.878174ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T09:02:16.38454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.296869ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T09:02:16.384628Z","caller":"traceutil/trace.go:171","msg":"trace[1939721036] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25294; }","duration":"106.442602ms","start":"2026-06-10T09:02:16.278166Z","end":"2026-06-10T09:02:16.384608Z","steps":["trace[1939721036] 'range keys from in-memory index tree' (duration: 106.198966ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T09:02:16.65356Z","caller":"traceutil/trace.go:171","msg":"trace[1953918691] transaction","detail":"{read_only:false; response_revision:25295; number_of_response:1; }","duration":"113.324093ms","start":"2026-06-10T09:02:16.540196Z","end":"2026-06-10T09:02:16.653521Z","steps":["trace[1953918691] 'process raft request' (duration: 113.109978ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T09:02:16.913276Z","caller":"traceutil/trace.go:171","msg":"trace[433973334] transaction","detail":"{read_only:false; response_revision:25297; number_of_response:1; }","duration":"254.064823ms","start":"2026-06-10T09:02:16.659191Z","end":"2026-06-10T09:02:16.913256Z","steps":["trace[433973334] 'process raft request' (duration: 253.967521ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T09:02:16.913472Z","caller":"traceutil/trace.go:171","msg":"trace[892738080] transaction","detail":"{read_only:false; response_revision:25296; number_of_response:1; }","duration":"255.189435ms","start":"2026-06-10T09:02:16.658217Z","end":"2026-06-10T09:02:16.913406Z","steps":["trace[892738080] 'process raft request' (duration: 251.167139ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T09:02:22.796551Z","caller":"traceutil/trace.go:171","msg":"trace[443262954] transaction","detail":"{read_only:false; response_revision:25337; number_of_response:1; }","duration":"166.528958ms","start":"2026-06-10T09:02:22.62998Z","end":"2026-06-10T09:02:22.796509Z","steps":["trace[443262954] 'process raft request' (duration: 98.686586ms)","trace[443262954] 'compare' (duration: 67.596738ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T09:02:22.843752Z","caller":"traceutil/trace.go:171","msg":"trace[1251078276] transaction","detail":"{read_only:false; response_revision:25338; number_of_response:1; }","duration":"170.031525ms","start":"2026-06-10T09:02:22.673687Z","end":"2026-06-10T09:02:22.843718Z","steps":["trace[1251078276] 'process raft request' (duration: 169.77918ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T09:02:22.844483Z","caller":"traceutil/trace.go:171","msg":"trace[325559695] transaction","detail":"{read_only:false; response_revision:25339; number_of_response:1; }","duration":"153.744967ms","start":"2026-06-10T09:02:22.690694Z","end":"2026-06-10T09:02:22.844439Z","steps":["trace[325559695] 'process raft request' (duration: 152.969933ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T09:02:23.101742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.820211ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-06-10T09:02:23.101842Z","caller":"traceutil/trace.go:171","msg":"trace[1460816441] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25339; }","duration":"160.991343ms","start":"2026-06-10T09:02:22.940826Z","end":"2026-06-10T09:02:23.101818Z","steps":["trace[1460816441] 'range keys from in-memory index tree' (duration: 160.593786ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T09:02:23.101874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.973685ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-10T09:02:23.101964Z","caller":"traceutil/trace.go:171","msg":"trace[357140298] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25339; }","duration":"159.119258ms","start":"2026-06-10T09:02:22.942824Z","end":"2026-06-10T09:02:23.101943Z","steps":["trace[357140298] 'range keys from in-memory index tree' (duration: 158.765562ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T09:02:23.323008Z","caller":"traceutil/trace.go:171","msg":"trace[1517699064] transaction","detail":"{read_only:false; response_revision:25340; number_of_response:1; }","duration":"217.037433ms","start":"2026-06-10T09:02:23.105934Z","end":"2026-06-10T09:02:23.322972Z","steps":["trace[1517699064] 'process raft request' (duration: 216.808409ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T09:02:23.507305Z","caller":"traceutil/trace.go:171","msg":"trace[25021032] transaction","detail":"{read_only:false; response_revision:25341; number_of_response:1; }","duration":"400.837329ms","start":"2026-06-10T09:02:23.106438Z","end":"2026-06-10T09:02:23.507276Z","steps":["trace[25021032] 'process raft request' (duration: 400.621085ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T09:02:23.507538Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T09:02:23.10643Z","time spent":"400.962351ms","remote":"127.0.0.1:54942","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T09:02:23.507673Z","caller":"traceutil/trace.go:171","msg":"trace[1058748934] transaction","detail":"{read_only:false; response_revision:25342; number_of_response:1; }","duration":"400.004753ms","start":"2026-06-10T09:02:23.107638Z","end":"2026-06-10T09:02:23.507643Z","steps":["trace[1058748934] 'process raft request' (duration: 399.593695ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T09:02:23.507869Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T09:02:23.10762Z","time spent":"400.143715ms","remote":"127.0.0.1:54942","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T09:02:23.507875Z","caller":"traceutil/trace.go:171","msg":"trace[2018280331] transaction","detail":"{read_only:false; response_revision:25345; number_of_response:1; }","duration":"273.330287ms","start":"2026-06-10T09:02:23.234529Z","end":"2026-06-10T09:02:23.507859Z","steps":["trace[2018280331] 'process raft request' (duration: 273.271116ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T09:02:23.50789Z","caller":"traceutil/trace.go:171","msg":"trace[1815530646] transaction","detail":"{read_only:false; response_revision:25343; number_of_response:1; }","duration":"321.731423ms","start":"2026-06-10T09:02:23.186124Z","end":"2026-06-10T09:02:23.507855Z","steps":["trace[1815530646] 'process raft request' (duration: 321.409597ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T09:02:23.507961Z","caller":"traceutil/trace.go:171","msg":"trace[883264536] transaction","detail":"{read_only:false; response_revision:25344; number_of_response:1; }","duration":"273.905168ms","start":"2026-06-10T09:02:23.234004Z","end":"2026-06-10T09:02:23.507909Z","steps":["trace[883264536] 'process raft request' (duration: 273.733235ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T09:02:23.508059Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T09:02:23.186092Z","time spent":"321.874936ms","remote":"127.0.0.1:54942","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":539,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T09:02:24.823228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.302261ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-10T09:02:24.823337Z","caller":"traceutil/trace.go:171","msg":"trace[1803576279] transaction","detail":"{read_only:false; response_revision:25357; number_of_response:1; }","duration":"162.922061ms","start":"2026-06-10T09:02:24.660392Z","end":"2026-06-10T09:02:24.823314Z","steps":["trace[1803576279] 'process raft request' (duration: 21.441066ms)","trace[1803576279] 'compare' (duration: 141.086297ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T09:02:24.844148Z","caller":"traceutil/trace.go:171","msg":"trace[2055903440] transaction","detail":"{read_only:false; response_revision:25358; number_of_response:1; }","duration":"183.562491ms","start":"2026-06-10T09:02:24.660566Z","end":"2026-06-10T09:02:24.844129Z","steps":["trace[2055903440] 'process raft request' (duration: 183.284625ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T09:02:24.844174Z","caller":"traceutil/trace.go:171","msg":"trace[1317686679] transaction","detail":"{read_only:false; response_revision:25359; number_of_response:1; }","duration":"183.201374ms","start":"2026-06-10T09:02:24.660943Z","end":"2026-06-10T09:02:24.844145Z","steps":["trace[1317686679] 'process raft request' (duration: 183.089181ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T09:02:24.844419Z","caller":"traceutil/trace.go:171","msg":"trace[353819881] linearizableReadLoop","detail":"{readStateIndex:26176; appliedIndex:26173; }","duration":"120.06675ms","start":"2026-06-10T09:02:24.724254Z","end":"2026-06-10T09:02:24.844321Z","steps":["trace[353819881] 'read index received' (duration: 119.56786ms)","trace[353819881] 'applied index is now lower than readState.Index' (duration: 495.16µs)"],"step_count":2} {"level":"warn","ts":"2026-06-10T09:02:24.844739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.446497ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-manila-server-0\" ","response":"range_response_count:1 size:1860"} {"level":"info","ts":"2026-06-10T09:02:24.844792Z","caller":"traceutil/trace.go:171","msg":"trace[898720035] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-manila-server-0; range_end:; response_count:1; response_revision:25360; }","duration":"120.544029ms","start":"2026-06-10T09:02:24.72423Z","end":"2026-06-10T09:02:24.844774Z","steps":["trace[898720035] 'agreement among raft nodes before linearized reading' (duration: 120.295214ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T09:02:24.844855Z","caller":"traceutil/trace.go:171","msg":"trace[1270067816] transaction","detail":"{read_only:false; response_revision:25360; number_of_response:1; }","duration":"182.848017ms","start":"2026-06-10T09:02:24.661991Z","end":"2026-06-10T09:02:24.844839Z","steps":["trace[1270067816] 'process raft request' (duration: 182.085732ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T09:02:28.265411Z","caller":"traceutil/trace.go:171","msg":"trace[1225116733] transaction","detail":"{read_only:false; response_revision:25393; number_of_response:1; }","duration":"103.036858ms","start":"2026-06-10T09:02:28.16234Z","end":"2026-06-10T09:02:28.265376Z","steps":["trace[1225116733] 'process raft request' (duration: 102.911906ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T09:02:28.265421Z","caller":"traceutil/trace.go:171","msg":"trace[813932555] transaction","detail":"{read_only:false; response_revision:25392; number_of_response:1; }","duration":"108.130934ms","start":"2026-06-10T09:02:28.157237Z","end":"2026-06-10T09:02:28.265368Z","steps":["trace[813932555] 'compare' (duration: 97.817029ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T09:02:44.689507Z","caller":"traceutil/trace.go:171","msg":"trace[518586469] transaction","detail":"{read_only:false; response_revision:25508; number_of_response:1; }","duration":"170.83963ms","start":"2026-06-10T09:02:44.518637Z","end":"2026-06-10T09:02:44.689476Z","steps":["trace[518586469] 'process raft request' (duration: 170.666557ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T09:02:44.785029Z","caller":"traceutil/trace.go:171","msg":"trace[1081010919] linearizableReadLoop","detail":"{readStateIndex:26329; appliedIndex:26328; }","duration":"258.67365ms","start":"2026-06-10T09:02:44.526333Z","end":"2026-06-10T09:02:44.785006Z","steps":["trace[1081010919] 'read index received' (duration: 163.980609ms)","trace[1081010919] 'applied index is now lower than readState.Index' (duration: 94.692331ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T09:02:44.785163Z","caller":"traceutil/trace.go:171","msg":"trace[1076650700] transaction","detail":"{read_only:false; response_revision:25510; number_of_response:1; }","duration":"207.748358ms","start":"2026-06-10T09:02:44.577388Z","end":"2026-06-10T09:02:44.785136Z","steps":["trace[1076650700] 'process raft request' (duration: 207.518734ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T09:02:44.785207Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.847984ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-10T09:02:44.785239Z","caller":"traceutil/trace.go:171","msg":"trace[1271313905] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:25510; }","duration":"258.923445ms","start":"2026-06-10T09:02:44.526304Z","end":"2026-06-10T09:02:44.785227Z","steps":["trace[1271313905] 'agreement among raft nodes before linearized reading' (duration: 258.832723ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T09:02:44.785373Z","caller":"traceutil/trace.go:171","msg":"trace[1114993418] transaction","detail":"{read_only:false; response_revision:25509; number_of_response:1; }","duration":"263.779588ms","start":"2026-06-10T09:02:44.521583Z","end":"2026-06-10T09:02:44.785363Z","steps":["trace[1114993418] 'process raft request' (duration: 196.978124ms)","trace[1114993418] 'compare' (duration: 65.949137ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T09:02:44.785442Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.535101ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/scrapeconfigs/\" range_end:\"/registry/monitoring.coreos.com/scrapeconfigs0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T09:02:44.785468Z","caller":"traceutil/trace.go:171","msg":"trace[533762976] range","detail":"{range_begin:/registry/monitoring.coreos.com/scrapeconfigs/; range_end:/registry/monitoring.coreos.com/scrapeconfigs0; response_count:0; response_revision:25510; }","duration":"219.583291ms","start":"2026-06-10T09:02:44.565874Z","end":"2026-06-10T09:02:44.785458Z","steps":["trace[533762976] 'agreement among raft nodes before linearized reading' (duration: 219.539991ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T09:02:45.283063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.825961ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-06-10T09:02:45.743758Z","caller":"traceutil/trace.go:171","msg":"trace[1703151785] transaction","detail":"{read_only:false; response_revision:25513; number_of_response:1; }","duration":"104.149069ms","start":"2026-06-10T09:02:45.639568Z","end":"2026-06-10T09:02:45.743717Z","steps":["trace[1703151785] 'process raft request' (duration: 103.917724ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T09:02:45.748712Z","caller":"traceutil/trace.go:171","msg":"trace[1230425422] transaction","detail":"{read_only:false; response_revision:25514; number_of_response:1; }","duration":"105.919043ms","start":"2026-06-10T09:02:45.642776Z","end":"2026-06-10T09:02:45.748696Z","steps":["trace[1230425422] 'process raft request' (duration: 105.609447ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T09:02:45.748856Z","caller":"traceutil/trace.go:171","msg":"trace[253844454] transaction","detail":"{read_only:false; response_revision:25515; number_of_response:1; }","duration":"106.047355ms","start":"2026-06-10T09:02:45.642802Z","end":"2026-06-10T09:02:45.748849Z","steps":["trace[253844454] 'process raft request' (duration: 105.672588ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T09:02:45.748921Z","caller":"traceutil/trace.go:171","msg":"trace[1983116587] transaction","detail":"{read_only:false; response_revision:25516; number_of_response:1; }","duration":"106.077736ms","start":"2026-06-10T09:02:45.642839Z","end":"2026-06-10T09:02:45.748916Z","steps":["trace[1983116587] 'process raft request' (duration: 105.658908ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T09:02:49.898378Z","caller":"traceutil/trace.go:171","msg":"trace[843230101] linearizableReadLoop","detail":"{readStateIndex:26369; appliedIndex:26363; }","duration":"131.70709ms","start":"2026-06-10T09:02:49.766649Z","end":"2026-06-10T09:02:49.898356Z","steps":["trace[843230101] 'read index received' (duration: 48.489256ms)","trace[843230101] 'applied index is now lower than readState.Index' (duration: 83.216804ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T09:02:49.898715Z","caller":"traceutil/trace.go:171","msg":"trace[473387546] transaction","detail":"{read_only:false; response_revision:25544; number_of_response:1; }","duration":"139.287994ms","start":"2026-06-10T09:02:49.759419Z","end":"2026-06-10T09:02:49.898707Z","steps":["trace[473387546] 'process raft request' (duration: 138.712994ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T09:02:49.898913Z","caller":"traceutil/trace.go:171","msg":"trace[342405332] transaction","detail":"{read_only:false; response_revision:25545; number_of_response:1; }","duration":"137.637122ms","start":"2026-06-10T09:02:49.761267Z","end":"2026-06-10T09:02:49.898904Z","steps":["trace[342405332] 'process raft request' (duration: 136.98186ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T09:02:49.899041Z","caller":"traceutil/trace.go:171","msg":"trace[1130187972] transaction","detail":"{read_only:false; response_revision:25546; number_of_response:1; }","duration":"136.579082ms","start":"2026-06-10T09:02:49.762453Z","end":"2026-06-10T09:02:49.899032Z","steps":["trace[1130187972] 'process raft request' (duration: 135.825588ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T09:02:49.899169Z","caller":"traceutil/trace.go:171","msg":"trace[1186354105] transaction","detail":"{read_only:false; response_revision:25547; number_of_response:1; }","duration":"136.356627ms","start":"2026-06-10T09:02:49.762802Z","end":"2026-06-10T09:02:49.899159Z","steps":["trace[1186354105] 'process raft request' (duration: 135.502672ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T09:02:49.899294Z","caller":"traceutil/trace.go:171","msg":"trace[1281584740] transaction","detail":"{read_only:false; response_revision:25548; number_of_response:1; }","duration":"136.324797ms","start":"2026-06-10T09:02:49.762961Z","end":"2026-06-10T09:02:49.899285Z","steps":["trace[1281584740] 'process raft request' (duration: 135.370469ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T09:02:49.899514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.84703ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-10T09:02:49.89954Z","caller":"traceutil/trace.go:171","msg":"trace[1927177915] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25548; }","duration":"132.890192ms","start":"2026-06-10T09:02:49.766643Z","end":"2026-06-10T09:02:49.899534Z","steps":["trace[1927177915] 'agreement among raft nodes before linearized reading' (duration: 132.774249ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T09:02:49.899738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.311507ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-06-10T09:02:49.89976Z","caller":"traceutil/trace.go:171","msg":"trace[1624588889] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25548; }","duration":"127.377798ms","start":"2026-06-10T09:02:49.772376Z","end":"2026-06-10T09:02:49.899754Z","steps":["trace[1624588889] 'agreement among raft nodes before linearized reading' (duration: 127.322037ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T09:02:55.119133Z","caller":"traceutil/trace.go:171","msg":"trace[1637066922] transaction","detail":"{read_only:false; response_revision:25596; number_of_response:1; }","duration":"103.330243ms","start":"2026-06-10T09:02:55.01577Z","end":"2026-06-10T09:02:55.1191Z","steps":["trace[1637066922] 'process raft request' (duration: 103.010457ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T09:02:55.435147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.157816ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-06-10T09:02:55.435565Z","caller":"traceutil/trace.go:171","msg":"trace[1064942319] linearizableReadLoop","detail":"{readStateIndex:26419; appliedIndex:26418; }","duration":"183.256163ms","start":"2026-06-10T09:02:55.252288Z","end":"2026-06-10T09:02:55.435544Z","steps":["trace[1064942319] 'read index received' (duration: 11.69668ms)","trace[1064942319] 'applied index is now lower than readState.Index' (duration: 171.557843ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T09:02:55.435851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.552411ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12211"} {"level":"info","ts":"2026-06-10T09:02:55.4359Z","caller":"traceutil/trace.go:171","msg":"trace[165330073] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25596; }","duration":"183.660672ms","start":"2026-06-10T09:02:55.252225Z","end":"2026-06-10T09:02:55.435886Z","steps":["trace[165330073] 'agreement among raft nodes before linearized reading' (duration: 183.432687ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T09:02:55.436476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.00276ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T09:02:55.436521Z","caller":"traceutil/trace.go:171","msg":"trace[1656683731] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25596; }","duration":"155.104302ms","start":"2026-06-10T09:02:55.281406Z","end":"2026-06-10T09:02:55.43651Z","steps":["trace[1656683731] 'agreement among raft nodes before linearized reading' (duration: 154.851757ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T09:02:56.021934Z","caller":"traceutil/trace.go:171","msg":"trace[929748950] transaction","detail":"{read_only:false; response_revision:25598; number_of_response:1; }","duration":"101.141162ms","start":"2026-06-10T09:02:55.920764Z","end":"2026-06-10T09:02:56.021905Z","steps":["trace[929748950] 'process raft request' (duration: 100.947189ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T09:02:56.214466Z","caller":"traceutil/trace.go:171","msg":"trace[617159371] transaction","detail":"{read_only:false; response_revision:25599; number_of_response:1; }","duration":"290.731477ms","start":"2026-06-10T09:02:55.923711Z","end":"2026-06-10T09:02:56.214442Z","steps":["trace[617159371] 'process raft request' (duration: 214.252031ms)","trace[617159371] 'compare' (duration: 76.17234ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T09:02:56.214737Z","caller":"traceutil/trace.go:171","msg":"trace[1523295627] transaction","detail":"{read_only:false; response_revision:25600; number_of_response:1; }","duration":"289.532714ms","start":"2026-06-10T09:02:55.925179Z","end":"2026-06-10T09:02:56.214711Z","steps":["trace[1523295627] 'process raft request' (duration: 289.224608ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T09:02:56.214848Z","caller":"traceutil/trace.go:171","msg":"trace[523360374] transaction","detail":"{read_only:false; response_revision:25603; number_of_response:1; }","duration":"116.210307ms","start":"2026-06-10T09:02:56.098628Z","end":"2026-06-10T09:02:56.214838Z","steps":["trace[523360374] 'process raft request' (duration: 116.172756ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T09:02:56.214849Z","caller":"traceutil/trace.go:171","msg":"trace[660318802] transaction","detail":"{read_only:false; response_revision:25601; number_of_response:1; }","duration":"289.643196ms","start":"2026-06-10T09:02:55.925179Z","end":"2026-06-10T09:02:56.214822Z","steps":["trace[660318802] 'process raft request' (duration: 289.447642ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T09:02:56.214958Z","caller":"traceutil/trace.go:171","msg":"trace[351270833] linearizableReadLoop","detail":"{readStateIndex:26425; appliedIndex:26420; }","duration":"280.830199ms","start":"2026-06-10T09:02:55.934115Z","end":"2026-06-10T09:02:56.214945Z","steps":["trace[351270833] 'read index received' (duration: 87.581465ms)","trace[351270833] 'applied index is now lower than readState.Index' (duration: 193.245364ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T09:02:56.214932Z","caller":"traceutil/trace.go:171","msg":"trace[88461634] transaction","detail":"{read_only:false; response_revision:25602; number_of_response:1; }","duration":"289.523704ms","start":"2026-06-10T09:02:55.925375Z","end":"2026-06-10T09:02:56.214899Z","steps":["trace[88461634] 'process raft request' (duration: 289.392002ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T09:02:56.215115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.997802ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-10T09:02:56.215152Z","caller":"traceutil/trace.go:171","msg":"trace[2145047055] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25603; }","duration":"281.097955ms","start":"2026-06-10T09:02:55.934042Z","end":"2026-06-10T09:02:56.21514Z","steps":["trace[2145047055] 'agreement among raft nodes before linearized reading' (duration: 280.950232ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T09:02:56.215272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.752497ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-06-10T09:02:56.215353Z","caller":"traceutil/trace.go:171","msg":"trace[1420815599] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25603; }","duration":"262.891109ms","start":"2026-06-10T09:02:55.952439Z","end":"2026-06-10T09:02:56.21533Z","steps":["trace[1420815599] 'agreement among raft nodes before linearized reading' (duration: 262.670905ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T09:02:56.216029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.037871ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T09:02:56.216081Z","caller":"traceutil/trace.go:171","msg":"trace[2115771612] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:25603; }","duration":"265.089051ms","start":"2026-06-10T09:02:55.950979Z","end":"2026-06-10T09:02:56.216068Z","steps":["trace[2115771612] 'agreement among raft nodes before linearized reading' (duration: 264.047431ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T09:02:56.447246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.994825ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-10T09:02:56.44741Z","caller":"traceutil/trace.go:171","msg":"trace[1835361879] linearizableReadLoop","detail":"{readStateIndex:26429; appliedIndex:26428; }","duration":"130.198891ms","start":"2026-06-10T09:02:56.317186Z","end":"2026-06-10T09:02:56.447385Z","steps":["trace[1835361879] 'read index received' (duration: 55.351µs)","trace[1835361879] 'applied index is now lower than readState.Index' (duration: 130.14077ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T09:02:56.447499Z","caller":"traceutil/trace.go:171","msg":"trace[1884385956] transaction","detail":"{read_only:false; response_revision:25606; number_of_response:1; }","duration":"146.327836ms","start":"2026-06-10T09:02:56.301129Z","end":"2026-06-10T09:02:56.447457Z","steps":["trace[1884385956] 'process raft request' (duration: 13.982314ms)","trace[1884385956] 'compare' (duration: 131.69126ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T09:02:56.447632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.81625ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T09:02:56.447704Z","caller":"traceutil/trace.go:171","msg":"trace[1933469725] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:25606; }","duration":"124.947672ms","start":"2026-06-10T09:02:56.322737Z","end":"2026-06-10T09:02:56.447685Z","steps":["trace[1933469725] 'agreement among raft nodes before linearized reading' (duration: 124.812189ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T09:02:56.447938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.583571ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"warn","ts":"2026-06-10T09:02:56.44799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.750382ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/machinepools/\" range_end:\"/registry/cluster.x-k8s.io/machinepools0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T09:02:56.448016Z","caller":"traceutil/trace.go:171","msg":"trace[2031265062] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:25606; }","duration":"118.738645ms","start":"2026-06-10T09:02:56.329261Z","end":"2026-06-10T09:02:56.448Z","steps":["trace[2031265062] 'agreement among raft nodes before linearized reading' (duration: 118.608821ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T09:02:56.448048Z","caller":"traceutil/trace.go:171","msg":"trace[1499138121] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machinepools/; range_end:/registry/cluster.x-k8s.io/machinepools0; response_count:0; response_revision:25606; }","duration":"130.897645ms","start":"2026-06-10T09:02:56.317132Z","end":"2026-06-10T09:02:56.44803Z","steps":["trace[1499138121] 'agreement among raft nodes before linearized reading' (duration: 130.742881ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T09:02:56.686268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.102642ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/addons.cluster.x-k8s.io/clusterresourcesetbindings/\" range_end:\"/registry/addons.cluster.x-k8s.io/clusterresourcesetbindings0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T09:02:56.686354Z","caller":"traceutil/trace.go:171","msg":"trace[399522053] range","detail":"{range_begin:/registry/addons.cluster.x-k8s.io/clusterresourcesetbindings/; range_end:/registry/addons.cluster.x-k8s.io/clusterresourcesetbindings0; response_count:0; response_revision:25606; }","duration":"128.245145ms","start":"2026-06-10T09:02:56.558086Z","end":"2026-06-10T09:02:56.686331Z","steps":["trace[399522053] 'count revisions from in-memory index tree' (duration: 127.99192ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T09:02:57.413432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.194474ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"warn","ts":"2026-06-10T09:02:57.413435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.773991ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T09:02:57.41351Z","caller":"traceutil/trace.go:171","msg":"trace[204652957] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:25609; }","duration":"164.314376ms","start":"2026-06-10T09:02:57.249179Z","end":"2026-06-10T09:02:57.413494Z","steps":["trace[204652957] 'count revisions from in-memory index tree' (duration: 164.145103ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T09:02:57.413548Z","caller":"traceutil/trace.go:171","msg":"trace[1154117420] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25609; }","duration":"132.924083ms","start":"2026-06-10T09:02:57.280597Z","end":"2026-06-10T09:02:57.413521Z","steps":["trace[1154117420] 'range keys from in-memory index tree' (duration: 132.716459ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T09:03:36.908596Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":23000} {"level":"info","ts":"2026-06-10T09:03:37.049339Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":23000,"took":"135.186486ms","hash":276603013,"current-db-size-bytes":57495552,"current-db-size":"58 MB","current-db-size-in-use-bytes":36024320,"current-db-size-in-use":"36 MB"} {"level":"info","ts":"2026-06-10T09:03:37.049421Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":276603013,"revision":23000,"compact-revision":20103} {"level":"info","ts":"2026-06-10T09:04:14.405644Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-0000000000006a64.wal"} {"level":"info","ts":"2026-06-10T09:08:36.915563Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":26072} {"level":"info","ts":"2026-06-10T09:08:37.072109Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":26072,"took":"149.12955ms","hash":1024416790,"current-db-size-bytes":58343424,"current-db-size":"58 MB","current-db-size-in-use-bytes":34926592,"current-db-size-in-use":"35 MB"} {"level":"info","ts":"2026-06-10T09:08:37.072168Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1024416790,"revision":26072,"compact-revision":23000} {"level":"info","ts":"2026-06-10T09:09:15.872728Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"597401b06ce1cf3d","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-10T09:09:15.878836Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003} {"level":"info","ts":"2026-06-10T09:09:15.878973Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003} {"level":"info","ts":"2026-06-10T09:13:36.921589Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":28803} {"level":"info","ts":"2026-06-10T09:13:37.070295Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":28803,"took":"143.236837ms","hash":693233230,"current-db-size-bytes":58343424,"current-db-size":"58 MB","current-db-size-in-use-bytes":30277632,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-06-10T09:13:37.070383Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":693233230,"revision":28803,"compact-revision":26072} {"level":"info","ts":"2026-06-10T09:18:36.929261Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":31023} {"level":"info","ts":"2026-06-10T09:18:37.064037Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":31023,"took":"129.392422ms","hash":4114896075,"current-db-size-bytes":58343424,"current-db-size":"58 MB","current-db-size-in-use-bytes":30298112,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-06-10T09:18:37.064161Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4114896075,"revision":31023,"compact-revision":28803} {"level":"info","ts":"2026-06-10T09:23:36.93711Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":33284} {"level":"info","ts":"2026-06-10T09:23:37.087855Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":33284,"took":"146.067847ms","hash":474244164,"current-db-size-bytes":58343424,"current-db-size":"58 MB","current-db-size-in-use-bytes":31268864,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-06-10T09:23:37.08792Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":474244164,"revision":33284,"compact-revision":31023} {"level":"info","ts":"2026-06-10T09:28:36.943838Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":35576} {"level":"info","ts":"2026-06-10T09:28:37.131069Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":35576,"took":"179.737274ms","hash":3958456918,"current-db-size-bytes":60030976,"current-db-size":"60 MB","current-db-size-in-use-bytes":31948800,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-06-10T09:28:37.131935Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3958456918,"revision":35576,"compact-revision":33284} {"level":"info","ts":"2026-06-10T09:30:42.920441Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"597401b06ce1cf3d","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-10T09:30:42.929872Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004} {"level":"info","ts":"2026-06-10T09:30:42.929971Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004} {"level":"info","ts":"2026-06-10T09:33:36.950458Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":37808} {"level":"info","ts":"2026-06-10T09:33:37.077462Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":37808,"took":"122.832819ms","hash":1116929107,"current-db-size-bytes":60030976,"current-db-size":"60 MB","current-db-size-in-use-bytes":31903744,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-06-10T09:33:37.077548Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1116929107,"revision":37808,"compact-revision":35576}