{"level":"warn","ts":"2026-06-30T17:54:18.492516Z","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-30T17:54:18.492596Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.57: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.57:2380","--initial-cluster=instance=https://199.204.45.57:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.57:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.57: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-30T17:54:18.492654Z","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-30T17:54:18.492667Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.57:2380"]} {"level":"info","ts":"2026-06-30T17:54:18.492693Z","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-30T17:54:18.496727Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.57:2379"]} {"level":"info","ts":"2026-06-30T17:54:18.496935Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.57:2380"],"listen-peer-urls":["https://199.204.45.57:2380"],"advertise-client-urls":["https://199.204.45.57:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.57:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.57: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-30T17:54:18.504478Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"7.169281ms"} {"level":"info","ts":"2026-06-30T17:54:18.511917Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"b6478f0ac5aeb8e1","cluster-id":"6c58cff80d4a5b62"} {"level":"info","ts":"2026-06-30T17:54:18.511997Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 switched to configuration voters=()"} {"level":"info","ts":"2026-06-30T17:54:18.51202Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 became follower at term 0"} {"level":"info","ts":"2026-06-30T17:54:18.512033Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft b6478f0ac5aeb8e1 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-30T17:54:18.512049Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 became follower at term 1"} {"level":"info","ts":"2026-06-30T17:54:18.512088Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 switched to configuration voters=(13134624114678348001)"} {"level":"warn","ts":"2026-06-30T17:54:18.520237Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-30T17:54:18.521637Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-30T17:54:18.52274Z","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-30T17:54:18.525575Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"b6478f0ac5aeb8e1","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-30T17:54:18.525821Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"b6478f0ac5aeb8e1","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-30T17:54:18.526011Z","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-30T17:54:18.5261Z","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-30T17:54:18.526111Z","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-30T17:54:18.526706Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 switched to configuration voters=(13134624114678348001)"} {"level":"info","ts":"2026-06-30T17:54:18.526842Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"6c58cff80d4a5b62","local-member-id":"b6478f0ac5aeb8e1","added-peer-id":"b6478f0ac5aeb8e1","added-peer-peer-urls":["https://199.204.45.57:2380"]} {"level":"info","ts":"2026-06-30T17:54:18.530891Z","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-30T17:54:18.530998Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.57:2380"} {"level":"info","ts":"2026-06-30T17:54:18.531073Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.57:2380"} {"level":"info","ts":"2026-06-30T17:54:18.531129Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"b6478f0ac5aeb8e1","initial-advertise-peer-urls":["https://199.204.45.57:2380"],"listen-peer-urls":["https://199.204.45.57:2380"],"advertise-client-urls":["https://199.204.45.57:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.57:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-30T17:54:18.531159Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-30T17:54:19.512291Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 is starting a new election at term 1"} {"level":"info","ts":"2026-06-30T17:54:19.512355Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-30T17:54:19.51238Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 received MsgPreVoteResp from b6478f0ac5aeb8e1 at term 1"} {"level":"info","ts":"2026-06-30T17:54:19.5124Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 became candidate at term 2"} {"level":"info","ts":"2026-06-30T17:54:19.512417Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 received MsgVoteResp from b6478f0ac5aeb8e1 at term 2"} {"level":"info","ts":"2026-06-30T17:54:19.512434Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 became leader at term 2"} {"level":"info","ts":"2026-06-30T17:54:19.512465Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: b6478f0ac5aeb8e1 elected leader b6478f0ac5aeb8e1 at term 2"} {"level":"info","ts":"2026-06-30T17:54:19.513918Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-30T17:54:19.516916Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-30T17:54:19.516915Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"b6478f0ac5aeb8e1","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.57:2379]}","request-path":"/0/members/b6478f0ac5aeb8e1/attributes","cluster-id":"6c58cff80d4a5b62","publish-timeout":"7s"} {"level":"info","ts":"2026-06-30T17:54:19.516988Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-30T17:54:19.517324Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-30T17:54:19.517398Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-30T17:54:19.517401Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"6c58cff80d4a5b62","local-member-id":"b6478f0ac5aeb8e1","cluster-version":"3.5"} {"level":"info","ts":"2026-06-30T17:54:19.517549Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-30T17:54:19.517589Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-30T17:54:19.519126Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.57:2379"} {"level":"info","ts":"2026-06-30T17:54:19.5203Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-30T17:54:31.942983Z","caller":"traceutil/trace.go:171","msg":"trace[851347326] transaction","detail":"{read_only:false; response_revision:354; number_of_response:1; }","duration":"757.594255ms","start":"2026-06-30T17:54:31.185365Z","end":"2026-06-30T17:54:31.942959Z","steps":["trace[851347326] 'process raft request' (duration: 757.445262ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:54:31.943567Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:54:31.185334Z","time spent":"757.748919ms","remote":"127.0.0.1:46376","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T17:54:36.21224Z","caller":"traceutil/trace.go:171","msg":"trace[710001590] transaction","detail":"{read_only:false; response_revision:372; number_of_response:1; }","duration":"125.455653ms","start":"2026-06-30T17:54:36.086757Z","end":"2026-06-30T17:54:36.212213Z","steps":["trace[710001590] 'process raft request' (duration: 125.285749ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:54:36.993287Z","caller":"traceutil/trace.go:171","msg":"trace[1272826764] linearizableReadLoop","detail":"{readStateIndex:386; appliedIndex:385; }","duration":"158.270692ms","start":"2026-06-30T17:54:36.834999Z","end":"2026-06-30T17:54:36.993269Z","steps":["trace[1272826764] 'read index received' (duration: 158.15ms)","trace[1272826764] 'applied index is now lower than readState.Index' (duration: 119.882µs)"],"step_count":2} {"level":"warn","ts":"2026-06-30T17:54:36.993441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.439286ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-30T17:54:36.99347Z","caller":"traceutil/trace.go:171","msg":"trace[1051568413] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:373; }","duration":"158.544769ms","start":"2026-06-30T17:54:36.834918Z","end":"2026-06-30T17:54:36.993463Z","steps":["trace[1051568413] 'agreement among raft nodes before linearized reading' (duration: 158.424066ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:54:36.993558Z","caller":"traceutil/trace.go:171","msg":"trace[2042141199] transaction","detail":"{read_only:false; response_revision:373; number_of_response:1; }","duration":"252.289327ms","start":"2026-06-30T17:54:36.741141Z","end":"2026-06-30T17:54:36.993431Z","steps":["trace[2042141199] 'process raft request' (duration: 251.99875ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:54:39.184577Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.848258589s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-30T17:54:39.185103Z","caller":"traceutil/trace.go:171","msg":"trace[884076664] transaction","detail":"{read_only:false; response_revision:374; number_of_response:1; }","duration":"2.188049171s","start":"2026-06-30T17:54:36.997004Z","end":"2026-06-30T17:54:39.185053Z","steps":["trace[884076664] 'process raft request' (duration: 338.476433ms)","trace[884076664] 'compare' (duration: 1.848136495s)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:54:39.185372Z","caller":"traceutil/trace.go:171","msg":"trace[2091351189] linearizableReadLoop","detail":"{readStateIndex:387; appliedIndex:386; }","duration":"2.142880933s","start":"2026-06-30T17:54:37.042251Z","end":"2026-06-30T17:54:39.185132Z","steps":["trace[2091351189] 'read index received' (duration: 293.146231ms)","trace[2091351189] 'applied index is now lower than readState.Index' (duration: 1.849723612s)"],"step_count":2} {"level":"warn","ts":"2026-06-30T17:54:39.186469Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:54:36.996976Z","time spent":"2.188316018s","remote":"127.0.0.1:46376","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T17:54:39.206125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.163857204s","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-30T17:54:39.206199Z","caller":"traceutil/trace.go:171","msg":"trace[1217586651] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:374; }","duration":"2.163977317s","start":"2026-06-30T17:54:37.042201Z","end":"2026-06-30T17:54:39.206179Z","steps":["trace[1217586651] 'agreement among raft nodes before linearized reading' (duration: 2.143510718s)","trace[1217586651] 'range keys from in-memory index tree' (duration: 18.466272ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T17:54:39.206241Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:54:37.042184Z","time spent":"2.164048458s","remote":"127.0.0.1:46376","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-30T17:54:39.206245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"728.017271ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-30T17:54:39.206222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.060738857s","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-30T17:54:39.206293Z","caller":"traceutil/trace.go:171","msg":"trace[1503643617] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:374; }","duration":"728.097532ms","start":"2026-06-30T17:54:38.478178Z","end":"2026-06-30T17:54:39.206276Z","steps":["trace[1503643617] 'agreement among raft nodes before linearized reading' (duration: 728.01057ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:54:39.206324Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:54:38.47816Z","time spent":"728.158864ms","remote":"127.0.0.1:46150","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-30T17:54:39.20632Z","caller":"traceutil/trace.go:171","msg":"trace[33126726] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:374; }","duration":"2.06086736s","start":"2026-06-30T17:54:37.145432Z","end":"2026-06-30T17:54:39.2063Z","steps":["trace[33126726] 'agreement among raft nodes before linearized reading' (duration: 2.060708496s)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:54:39.20637Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:54:37.145415Z","time spent":"2.060941972s","remote":"127.0.0.1:46376","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":"warn","ts":"2026-06-30T17:54:39.20624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.634744ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-30T17:54:39.206478Z","caller":"traceutil/trace.go:171","msg":"trace[1964499322] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:374; }","duration":"208.91282ms","start":"2026-06-30T17:54:38.997542Z","end":"2026-06-30T17:54:39.206455Z","steps":["trace[1964499322] 'agreement among raft nodes before linearized reading' (duration: 208.619474ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:54:39.363042Z","caller":"traceutil/trace.go:171","msg":"trace[485429037] transaction","detail":"{read_only:false; response_revision:376; number_of_response:1; }","duration":"151.916496ms","start":"2026-06-30T17:54:39.211106Z","end":"2026-06-30T17:54:39.363022Z","steps":["trace[485429037] 'process raft request' (duration: 91.946783ms)","trace[485429037] 'compare' (duration: 59.760859ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:54:39.363545Z","caller":"traceutil/trace.go:171","msg":"trace[1372888636] transaction","detail":"{read_only:false; response_revision:377; number_of_response:1; }","duration":"151.820584ms","start":"2026-06-30T17:54:39.211554Z","end":"2026-06-30T17:54:39.363374Z","steps":["trace[1372888636] 'process raft request' (duration: 151.373033ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:54:44.362035Z","caller":"traceutil/trace.go:171","msg":"trace[1941283494] transaction","detail":"{read_only:false; response_revision:388; number_of_response:1; }","duration":"110.843427ms","start":"2026-06-30T17:54:44.251168Z","end":"2026-06-30T17:54:44.362011Z","steps":["trace[1941283494] 'process raft request' (duration: 110.719684ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:54:44.506786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.483895ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-30T17:54:44.507026Z","caller":"traceutil/trace.go:171","msg":"trace[1771951795] transaction","detail":"{read_only:false; response_revision:389; number_of_response:1; }","duration":"140.429248ms","start":"2026-06-30T17:54:44.366553Z","end":"2026-06-30T17:54:44.506983Z","steps":["trace[1771951795] 'process raft request' (duration: 27.655256ms)","trace[1771951795] 'compare' (duration: 112.341662ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T17:54:45.581107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.503301ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-30T17:54:45.58119Z","caller":"traceutil/trace.go:171","msg":"trace[2006040574] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:392; }","duration":"174.626953ms","start":"2026-06-30T17:54:45.406545Z","end":"2026-06-30T17:54:45.581172Z","steps":["trace[2006040574] 'range keys from in-memory index tree' (duration: 174.375948ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:54:45.723346Z","caller":"traceutil/trace.go:171","msg":"trace[475460354] transaction","detail":"{read_only:false; response_revision:393; number_of_response:1; }","duration":"138.241905ms","start":"2026-06-30T17:54:45.58508Z","end":"2026-06-30T17:54:45.723322Z","steps":["trace[475460354] 'process raft request' (duration: 138.085681ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:54:45.997533Z","caller":"traceutil/trace.go:171","msg":"trace[1974473134] transaction","detail":"{read_only:false; response_revision:398; number_of_response:1; }","duration":"128.221081ms","start":"2026-06-30T17:54:45.86929Z","end":"2026-06-30T17:54:45.997511Z","steps":["trace[1974473134] 'process raft request' (duration: 128.1487ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:54:45.997573Z","caller":"traceutil/trace.go:171","msg":"trace[1884351955] transaction","detail":"{read_only:false; response_revision:397; number_of_response:1; }","duration":"132.170984ms","start":"2026-06-30T17:54:45.865352Z","end":"2026-06-30T17:54:45.997523Z","steps":["trace[1884351955] 'process raft request' (duration: 112.755161ms)","trace[1884351955] 'compare' (duration: 19.187537ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:54:46.106264Z","caller":"traceutil/trace.go:171","msg":"trace[1886736115] transaction","detail":"{read_only:false; response_revision:403; number_of_response:1; }","duration":"100.76003ms","start":"2026-06-30T17:54:46.005478Z","end":"2026-06-30T17:54:46.106238Z","steps":["trace[1886736115] 'process raft request' (duration: 100.703519ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:54:46.106591Z","caller":"traceutil/trace.go:171","msg":"trace[1764582227] transaction","detail":"{read_only:false; response_revision:400; number_of_response:1; }","duration":"103.214197ms","start":"2026-06-30T17:54:46.003366Z","end":"2026-06-30T17:54:46.10658Z","steps":["trace[1764582227] 'process raft request' (duration: 94.377461ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:54:46.10692Z","caller":"traceutil/trace.go:171","msg":"trace[1727874224] transaction","detail":"{read_only:false; response_revision:401; number_of_response:1; }","duration":"103.022512ms","start":"2026-06-30T17:54:46.003883Z","end":"2026-06-30T17:54:46.106906Z","steps":["trace[1727874224] 'process raft request' (duration: 102.175403ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:54:46.107072Z","caller":"traceutil/trace.go:171","msg":"trace[1699494426] transaction","detail":"{read_only:false; response_revision:402; number_of_response:1; }","duration":"103.133965ms","start":"2026-06-30T17:54:46.003929Z","end":"2026-06-30T17:54:46.107063Z","steps":["trace[1699494426] 'process raft request' (duration: 102.195203ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:54:58.97824Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13322104105328907340,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-30T17:54:59.0397Z","caller":"traceutil/trace.go:171","msg":"trace[1575412649] transaction","detail":"{read_only:false; response_revision:486; number_of_response:1; }","duration":"654.707477ms","start":"2026-06-30T17:54:58.384968Z","end":"2026-06-30T17:54:59.039676Z","steps":["trace[1575412649] 'process raft request' (duration: 654.579994ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:54:59.039845Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:54:58.384942Z","time spent":"654.84023ms","remote":"127.0.0.1:46194","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-30T17:54:59.163165Z","caller":"traceutil/trace.go:171","msg":"trace[1053517488] transaction","detail":"{read_only:false; response_revision:487; number_of_response:1; }","duration":"769.866738ms","start":"2026-06-30T17:54:58.393261Z","end":"2026-06-30T17:54:59.163127Z","steps":["trace[1053517488] 'process raft request' (duration: 769.678073ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:54:59.163308Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:54:58.393256Z","time spent":"769.9826ms","remote":"127.0.0.1:46194","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-30T17:54:59.163429Z","caller":"traceutil/trace.go:171","msg":"trace[1904390826] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"770.221976ms","start":"2026-06-30T17:54:58.393197Z","end":"2026-06-30T17:54:59.163419Z","steps":["trace[1904390826] 'process raft request' (duration: 769.854548ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:54:59.163384Z","caller":"traceutil/trace.go:171","msg":"trace[522490747] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"759.697182ms","start":"2026-06-30T17:54:58.403652Z","end":"2026-06-30T17:54:59.163349Z","steps":["trace[522490747] 'process raft request' (duration: 759.492337ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:54:59.163356Z","caller":"traceutil/trace.go:171","msg":"trace[2047563960] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"759.746843ms","start":"2026-06-30T17:54:58.403583Z","end":"2026-06-30T17:54:59.16333Z","steps":["trace[2047563960] 'process raft request' (duration: 759.511328ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:54:59.163472Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:54:58.393179Z","time spent":"770.274467ms","remote":"127.0.0.1:46194","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-30T17:54:59.163533Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:54:58.403647Z","time spent":"759.822014ms","remote":"127.0.0.1:46194","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-30T17:54:59.163668Z","caller":"traceutil/trace.go:171","msg":"trace[247317718] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"757.985232ms","start":"2026-06-30T17:54:58.40567Z","end":"2026-06-30T17:54:59.163655Z","steps":["trace[247317718] 'process raft request' (duration: 757.514691ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:54:59.163714Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:54:58.405652Z","time spent":"758.041444ms","remote":"127.0.0.1:46194","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-30T17:54:59.163703Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:54:58.403565Z","time spent":"759.912137ms","remote":"127.0.0.1:46194","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-30T17:54:59.163804Z","caller":"traceutil/trace.go:171","msg":"trace[923975859] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"758.005013ms","start":"2026-06-30T17:54:58.405731Z","end":"2026-06-30T17:54:59.163736Z","steps":["trace[923975859] 'process raft request' (duration: 757.493671ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:54:59.164056Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:54:58.405723Z","time spent":"758.250598ms","remote":"127.0.0.1:46194","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-30T17:54:59.164131Z","caller":"traceutil/trace.go:171","msg":"trace[477510] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"758.071594ms","start":"2026-06-30T17:54:58.4059Z","end":"2026-06-30T17:54:59.163972Z","steps":["trace[477510] 'process raft request' (duration: 757.747767ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:54:59.164161Z","caller":"traceutil/trace.go:171","msg":"trace[1846860313] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"747.738424ms","start":"2026-06-30T17:54:58.41641Z","end":"2026-06-30T17:54:59.164149Z","steps":["trace[1846860313] 'process raft request' (duration: 747.466878ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:54:59.164424Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:54:58.416393Z","time spent":"748.004451ms","remote":"127.0.0.1:46194","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-30T17:54:59.164588Z","caller":"traceutil/trace.go:171","msg":"trace[217747174] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"748.066042ms","start":"2026-06-30T17:54:58.416505Z","end":"2026-06-30T17:54:59.164571Z","steps":["trace[217747174] 'process raft request' (duration: 747.440028ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:54:59.164662Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:54:58.416481Z","time spent":"748.157245ms","remote":"127.0.0.1:46194","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-30T17:54:59.164327Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:54:58.405896Z","time spent":"758.400732ms","remote":"127.0.0.1:46194","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-30T17:54:59.165947Z","caller":"traceutil/trace.go:171","msg":"trace[1504570025] linearizableReadLoop","detail":"{readStateIndex:516; appliedIndex:504; }","duration":"688.406269ms","start":"2026-06-30T17:54:58.477526Z","end":"2026-06-30T17:54:59.165933Z","steps":["trace[1504570025] 'read index received' (duration: 562.12019ms)","trace[1504570025] 'applied index is now lower than readState.Index' (duration: 126.285379ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T17:54:59.166016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"688.4835ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T17:54:59.166038Z","caller":"traceutil/trace.go:171","msg":"trace[1534081646] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:497; }","duration":"688.539782ms","start":"2026-06-30T17:54:58.47749Z","end":"2026-06-30T17:54:59.16603Z","steps":["trace[1534081646] 'agreement among raft nodes before linearized reading' (duration: 688.486321ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:54:59.166092Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:54:58.477455Z","time spent":"688.629573ms","remote":"127.0.0.1:46150","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-30T17:54:59.166217Z","caller":"traceutil/trace.go:171","msg":"trace[37105678] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"727.069725ms","start":"2026-06-30T17:54:58.43914Z","end":"2026-06-30T17:54:59.16621Z","steps":["trace[37105678] 'process raft request' (duration: 725.282894ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:54:59.166281Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:54:58.439108Z","time spent":"727.151047ms","remote":"127.0.0.1:46194","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-30T17:54:59.16635Z","caller":"traceutil/trace.go:171","msg":"trace[862284369] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"601.958222ms","start":"2026-06-30T17:54:58.564386Z","end":"2026-06-30T17:54:59.166344Z","steps":["trace[862284369] 'process raft request' (duration: 601.43957ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:54:59.166382Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:54:58.564355Z","time spent":"602.013984ms","remote":"127.0.0.1:46194","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-30T17:54:59.241671Z","caller":"traceutil/trace.go:171","msg":"trace[1352404125] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"196.21149ms","start":"2026-06-30T17:54:59.045435Z","end":"2026-06-30T17:54:59.241647Z","steps":["trace[1352404125] 'process raft request' (duration: 193.728273ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:54:59.241736Z","caller":"traceutil/trace.go:171","msg":"trace[310627501] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"194.680515ms","start":"2026-06-30T17:54:59.047027Z","end":"2026-06-30T17:54:59.241707Z","steps":["trace[310627501] 'process raft request' (duration: 194.49126ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:54:59.242032Z","caller":"traceutil/trace.go:171","msg":"trace[1539327751] transaction","detail":"{read_only:false; number_of_response:1; response_revision:499; }","duration":"194.755126ms","start":"2026-06-30T17:54:59.047255Z","end":"2026-06-30T17:54:59.24201Z","steps":["trace[1539327751] 'process raft request' (duration: 194.346896ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:55:04.929986Z","caller":"traceutil/trace.go:171","msg":"trace[1982853395] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"343.960924ms","start":"2026-06-30T17:55:04.585987Z","end":"2026-06-30T17:55:04.929948Z","steps":["trace[1982853395] 'process raft request' (duration: 337.934934ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:55:04.930205Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:55:04.585964Z","time spent":"344.152909ms","remote":"127.0.0.1:46230","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036261,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T17:55:06.596092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"558.397722ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-30T17:55:06.596627Z","caller":"traceutil/trace.go:171","msg":"trace[1366545975] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"783.089753ms","start":"2026-06-30T17:55:05.813496Z","end":"2026-06-30T17:55:06.596586Z","steps":["trace[1366545975] 'process raft request' (duration: 224.111198ms)","trace[1366545975] 'compare' (duration: 558.273178ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T17:55:06.59679Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:55:05.813456Z","time spent":"783.253257ms","remote":"127.0.0.1:46376","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T17:55:06.596852Z","caller":"traceutil/trace.go:171","msg":"trace[1200712778] linearizableReadLoop","detail":"{readStateIndex:622; appliedIndex:620; }","duration":"545.156085ms","start":"2026-06-30T17:55:06.051677Z","end":"2026-06-30T17:55:06.596833Z","steps":["trace[1200712778] 'read index received' (duration: 421.270158ms)","trace[1200712778] 'applied index is now lower than readState.Index' (duration: 123.885077ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T17:55:06.597253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"545.571045ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-hsjzh\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-06-30T17:55:06.597301Z","caller":"traceutil/trace.go:171","msg":"trace[515860154] range","detail":"{range_begin:/registry/pods/kube-system/cilium-hsjzh; range_end:; response_count:1; response_revision:599; }","duration":"545.658907ms","start":"2026-06-30T17:55:06.051628Z","end":"2026-06-30T17:55:06.597287Z","steps":["trace[515860154] 'agreement among raft nodes before linearized reading' (duration: 545.482453ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:55:06.597333Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:55:06.051605Z","time spent":"545.721499ms","remote":"127.0.0.1:46316","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16984,"request content":"key:\"/registry/pods/kube-system/cilium-hsjzh\" "} {"level":"warn","ts":"2026-06-30T17:55:06.597608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.563131ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T17:55:06.597878Z","caller":"traceutil/trace.go:171","msg":"trace[1841059951] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:599; }","duration":"117.788266ms","start":"2026-06-30T17:55:06.47995Z","end":"2026-06-30T17:55:06.597738Z","steps":["trace[1841059951] 'agreement among raft nodes before linearized reading' (duration: 117.552631ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:55:06.597404Z","caller":"traceutil/trace.go:171","msg":"trace[876905640] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"609.239009ms","start":"2026-06-30T17:55:05.988085Z","end":"2026-06-30T17:55:06.597324Z","steps":["trace[876905640] 'process raft request' (duration: 608.328508ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:55:06.598417Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:55:05.987995Z","time spent":"610.338124ms","remote":"127.0.0.1:46230","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036309,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T17:55:06.99822Z","caller":"traceutil/trace.go:171","msg":"trace[1090251559] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"379.203824ms","start":"2026-06-30T17:55:06.618993Z","end":"2026-06-30T17:55:06.998197Z","steps":["trace[1090251559] 'process raft request' (duration: 379.063081ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:55:06.998367Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:55:06.618951Z","time spent":"379.336368ms","remote":"127.0.0.1:46316","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T17:55:07.036413Z","caller":"traceutil/trace.go:171","msg":"trace[761551922] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"385.235433ms","start":"2026-06-30T17:55:06.651145Z","end":"2026-06-30T17:55:07.036381Z","steps":["trace[761551922] 'process raft request' (duration: 385.120121ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:55:07.036539Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:55:06.651115Z","time spent":"385.366216ms","remote":"127.0.0.1:46360","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-30T17:55:07.883399Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13322104105328907539,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-30T17:55:08.572849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"654.15116ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-30T17:55:08.573026Z","caller":"traceutil/trace.go:171","msg":"trace[41723487] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"1.521391344s","start":"2026-06-30T17:55:07.051607Z","end":"2026-06-30T17:55:08.572999Z","steps":["trace[41723487] 'process raft request' (duration: 867.027528ms)","trace[41723487] 'compare' (duration: 653.763922ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T17:55:08.573123Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:55:07.051528Z","time spent":"1.521557268s","remote":"127.0.0.1:46316","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2735,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-30T17:55:08.580957Z","caller":"traceutil/trace.go:171","msg":"trace[1454710382] linearizableReadLoop","detail":"{readStateIndex:626; appliedIndex:624; }","duration":"1.198120634s","start":"2026-06-30T17:55:07.382786Z","end":"2026-06-30T17:55:08.580906Z","steps":["trace[1454710382] 'read index received' (duration: 535.861537ms)","trace[1454710382] 'applied index is now lower than readState.Index' (duration: 662.257907ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T17:55:08.581303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.198511544s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-30T17:55:08.581395Z","caller":"traceutil/trace.go:171","msg":"trace[2053208005] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:602; }","duration":"1.198652586s","start":"2026-06-30T17:55:07.382729Z","end":"2026-06-30T17:55:08.581382Z","steps":["trace[2053208005] 'agreement among raft nodes before linearized reading' (duration: 1.198332129s)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:55:08.581469Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:55:07.382706Z","time spent":"1.198751289s","remote":"127.0.0.1:46376","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-30T17:55:08.68797Z","caller":"traceutil/trace.go:171","msg":"trace[1408400660] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"110.710851ms","start":"2026-06-30T17:55:08.577231Z","end":"2026-06-30T17:55:08.687941Z","steps":["trace[1408400660] 'process raft request' (duration: 95.996251ms)","trace[1408400660] 'compare' (duration: 14.476325ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:55:08.688033Z","caller":"traceutil/trace.go:171","msg":"trace[1135395769] linearizableReadLoop","detail":"{readStateIndex:630; appliedIndex:626; }","duration":"106.975614ms","start":"2026-06-30T17:55:08.581042Z","end":"2026-06-30T17:55:08.688017Z","steps":["trace[1135395769] 'read index received' (duration: 30.332812ms)","trace[1135395769] 'applied index is now lower than readState.Index' (duration: 76.641822ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:55:08.688042Z","caller":"traceutil/trace.go:171","msg":"trace[565348995] transaction","detail":"{read_only:false; response_revision:605; number_of_response:1; }","duration":"109.292738ms","start":"2026-06-30T17:55:08.578715Z","end":"2026-06-30T17:55:08.688008Z","steps":["trace[565348995] 'process raft request' (duration: 109.121944ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:55:08.688266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.342152ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T17:55:08.688413Z","caller":"traceutil/trace.go:171","msg":"trace[582182391] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:607; }","duration":"209.497726ms","start":"2026-06-30T17:55:08.478847Z","end":"2026-06-30T17:55:08.688344Z","steps":["trace[582182391] 'agreement among raft nodes before linearized reading' (duration: 209.322731ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:55:08.688428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.096693608s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-30T17:55:08.688492Z","caller":"traceutil/trace.go:171","msg":"trace[840077609] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:607; }","duration":"1.09682757s","start":"2026-06-30T17:55:07.591644Z","end":"2026-06-30T17:55:08.688472Z","steps":["trace[840077609] 'agreement among raft nodes before linearized reading' (duration: 1.096692267s)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:55:08.688618Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:55:07.591628Z","time spent":"1.096974564s","remote":"127.0.0.1:46376","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-30T17:55:08.68877Z","caller":"traceutil/trace.go:171","msg":"trace[121984343] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"104.359574ms","start":"2026-06-30T17:55:08.584388Z","end":"2026-06-30T17:55:08.688748Z","steps":["trace[121984343] 'process raft request' (duration: 103.572836ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:55:08.688804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.271958283s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-06-30T17:55:08.688835Z","caller":"traceutil/trace.go:171","msg":"trace[461747591] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:607; }","duration":"1.272047195s","start":"2026-06-30T17:55:07.41678Z","end":"2026-06-30T17:55:08.688827Z","steps":["trace[461747591] 'agreement among raft nodes before linearized reading' (duration: 1.271972603s)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:55:08.688855Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:55:07.41674Z","time spent":"1.272109826s","remote":"127.0.0.1:46376","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-30T17:55:08.68892Z","caller":"traceutil/trace.go:171","msg":"trace[1434791093] transaction","detail":"{read_only:false; response_revision:606; number_of_response:1; }","duration":"108.133792ms","start":"2026-06-30T17:55:08.58078Z","end":"2026-06-30T17:55:08.688914Z","steps":["trace[1434791093] 'process raft request' (duration: 107.138319ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:55:09.287811Z","caller":"traceutil/trace.go:171","msg":"trace[974403918] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"137.679604ms","start":"2026-06-30T17:55:09.150104Z","end":"2026-06-30T17:55:09.287783Z","steps":["trace[974403918] 'process raft request' (duration: 131.304366ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:55:10.911848Z","caller":"traceutil/trace.go:171","msg":"trace[134676437] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"147.136831ms","start":"2026-06-30T17:55:10.764673Z","end":"2026-06-30T17:55:10.91181Z","steps":["trace[134676437] 'process raft request' (duration: 146.881685ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:55:10.911975Z","caller":"traceutil/trace.go:171","msg":"trace[2076534750] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"146.476526ms","start":"2026-06-30T17:55:10.765478Z","end":"2026-06-30T17:55:10.911954Z","steps":["trace[2076534750] 'process raft request' (duration: 146.277652ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:55:11.534275Z","caller":"traceutil/trace.go:171","msg":"trace[110594998] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"443.004749ms","start":"2026-06-30T17:55:11.09122Z","end":"2026-06-30T17:55:11.534224Z","steps":["trace[110594998] 'process raft request' (duration: 347.186354ms)","trace[110594998] 'compare' (duration: 95.325243ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T17:55:11.534511Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:55:11.091207Z","time spent":"443.187773ms","remote":"127.0.0.1:46316","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17505,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T17:55:13.238682Z","caller":"traceutil/trace.go:171","msg":"trace[2132837168] transaction","detail":"{read_only:false; response_revision:656; number_of_response:1; }","duration":"142.279287ms","start":"2026-06-30T17:55:13.096376Z","end":"2026-06-30T17:55:13.238656Z","steps":["trace[2132837168] 'process raft request' (duration: 50.972147ms)","trace[2132837168] 'compare' (duration: 91.209658ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:55:13.257865Z","caller":"traceutil/trace.go:171","msg":"trace[1710181969] transaction","detail":"{read_only:false; response_revision:657; number_of_response:1; }","duration":"106.201604ms","start":"2026-06-30T17:55:13.151629Z","end":"2026-06-30T17:55:13.257831Z","steps":["trace[1710181969] 'process raft request' (duration: 106.058831ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:55:13.431294Z","caller":"traceutil/trace.go:171","msg":"trace[142939523] linearizableReadLoop","detail":"{readStateIndex:685; appliedIndex:684; }","duration":"119.680895ms","start":"2026-06-30T17:55:13.311586Z","end":"2026-06-30T17:55:13.431267Z","steps":["trace[142939523] 'read index received' (duration: 53.335802ms)","trace[142939523] 'applied index is now lower than readState.Index' (duration: 66.343933ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:55:13.431451Z","caller":"traceutil/trace.go:171","msg":"trace[1756659103] transaction","detail":"{read_only:false; response_revision:660; number_of_response:1; }","duration":"141.187022ms","start":"2026-06-30T17:55:13.290223Z","end":"2026-06-30T17:55:13.43141Z","steps":["trace[1756659103] 'process raft request' (duration: 74.805468ms)","trace[1756659103] 'compare' (duration: 66.121108ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T17:55:13.43152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.91234ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-hsjzh\" ","response":"range_response_count:1 size:17704"} {"level":"info","ts":"2026-06-30T17:55:13.43156Z","caller":"traceutil/trace.go:171","msg":"trace[2086563407] range","detail":"{range_begin:/registry/pods/kube-system/cilium-hsjzh; range_end:; response_count:1; response_revision:660; }","duration":"120.022823ms","start":"2026-06-30T17:55:13.311526Z","end":"2026-06-30T17:55:13.431548Z","steps":["trace[2086563407] 'agreement among raft nodes before linearized reading' (duration: 119.866689ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:55:13.445228Z","caller":"traceutil/trace.go:171","msg":"trace[1620509926] transaction","detail":"{read_only:false; response_revision:661; number_of_response:1; }","duration":"126.154394ms","start":"2026-06-30T17:55:13.319035Z","end":"2026-06-30T17:55:13.445189Z","steps":["trace[1620509926] 'process raft request' (duration: 125.846247ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:55:15.256967Z","caller":"traceutil/trace.go:171","msg":"trace[261765499] transaction","detail":"{read_only:false; response_revision:677; number_of_response:1; }","duration":"105.779833ms","start":"2026-06-30T17:55:15.151169Z","end":"2026-06-30T17:55:15.256949Z","steps":["trace[261765499] 'process raft request' (duration: 105.63984ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:55:22.329161Z","caller":"traceutil/trace.go:171","msg":"trace[995486955] transaction","detail":"{read_only:false; response_revision:743; number_of_response:1; }","duration":"103.354553ms","start":"2026-06-30T17:55:22.225778Z","end":"2026-06-30T17:55:22.329133Z","steps":["trace[995486955] 'process raft request' (duration: 103.210547ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:55:23.209131Z","caller":"traceutil/trace.go:171","msg":"trace[524761146] transaction","detail":"{read_only:false; response_revision:754; number_of_response:1; }","duration":"113.750773ms","start":"2026-06-30T17:55:23.095338Z","end":"2026-06-30T17:55:23.209089Z","steps":["trace[524761146] 'process raft request' (duration: 94.673955ms)","trace[524761146] 'compare' (duration: 18.752786ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T17:55:26.594646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.574842ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T17:55:26.594724Z","caller":"traceutil/trace.go:171","msg":"trace[620307525] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:770; }","duration":"288.706938ms","start":"2026-06-30T17:55:26.306Z","end":"2026-06-30T17:55:26.594707Z","steps":["trace[620307525] 'count revisions from in-memory index tree' (duration: 288.445208ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:55:26.594808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.252071ms","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-30T17:55:26.594863Z","caller":"traceutil/trace.go:171","msg":"trace[963725939] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:770; }","duration":"183.340484ms","start":"2026-06-30T17:55:26.411507Z","end":"2026-06-30T17:55:26.594847Z","steps":["trace[963725939] 'range keys from in-memory index tree' (duration: 183.112955ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:55:26.594911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"421.245998ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-w2ltr\" ","response":"range_response_count:1 size:3964"} {"level":"info","ts":"2026-06-30T17:55:26.596058Z","caller":"traceutil/trace.go:171","msg":"trace[1313333187] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-w2ltr; range_end:; response_count:1; response_revision:770; }","duration":"421.430056ms","start":"2026-06-30T17:55:26.173604Z","end":"2026-06-30T17:55:26.595034Z","steps":["trace[1313333187] 'range keys from in-memory index tree' (duration: 421.105373ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:55:26.596584Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:55:26.173586Z","time spent":"422.978772ms","remote":"127.0.0.1:46316","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3987,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-w2ltr\" "} {"level":"warn","ts":"2026-06-30T17:55:30.881814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.816097ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-30T17:55:30.881939Z","caller":"traceutil/trace.go:171","msg":"trace[1655566827] transaction","detail":"{read_only:false; response_revision:815; number_of_response:1; }","duration":"206.833396ms","start":"2026-06-30T17:55:30.675086Z","end":"2026-06-30T17:55:30.88192Z","steps":["trace[1655566827] 'process raft request' (duration: 102.833242ms)","trace[1655566827] 'compare' (duration: 102.661646ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T17:55:31.14852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.986665ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-30T17:55:31.148628Z","caller":"traceutil/trace.go:171","msg":"trace[460677708] linearizableReadLoop","detail":"{readStateIndex:848; appliedIndex:846; }","duration":"227.045533ms","start":"2026-06-30T17:55:30.921565Z","end":"2026-06-30T17:55:31.148611Z","steps":["trace[460677708] 'read index received' (duration: 34.852905ms)","trace[460677708] 'applied index is now lower than readState.Index' (duration: 192.191268ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T17:55:31.148934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.322003ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T17:55:31.148982Z","caller":"traceutil/trace.go:171","msg":"trace[1205642765] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:818; }","duration":"227.443707ms","start":"2026-06-30T17:55:30.921528Z","end":"2026-06-30T17:55:31.148971Z","steps":["trace[1205642765] 'agreement among raft nodes before linearized reading' (duration: 227.171378ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:55:31.148992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.339439ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-30T17:55:31.149082Z","caller":"traceutil/trace.go:171","msg":"trace[542717148] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:818; }","duration":"196.490125ms","start":"2026-06-30T17:55:30.952572Z","end":"2026-06-30T17:55:31.149062Z","steps":["trace[542717148] 'agreement among raft nodes before linearized reading' (duration: 196.216865ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:55:31.148727Z","caller":"traceutil/trace.go:171","msg":"trace[730957177] transaction","detail":"{read_only:false; response_revision:818; number_of_response:1; }","duration":"252.359142ms","start":"2026-06-30T17:55:30.896333Z","end":"2026-06-30T17:55:31.148692Z","steps":["trace[730957177] 'process raft request' (duration: 88.094577ms)","trace[730957177] 'compare' (duration: 163.83834ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T17:55:31.150108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.396695ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:5 size:1050252"} {"level":"info","ts":"2026-06-30T17:55:31.150173Z","caller":"traceutil/trace.go:171","msg":"trace[591559523] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:5; response_revision:818; }","duration":"160.496398ms","start":"2026-06-30T17:55:30.989659Z","end":"2026-06-30T17:55:31.150155Z","steps":["trace[591559523] 'agreement among raft nodes before linearized reading' (duration: 159.1678ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:55:31.450038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.938977ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-30T17:55:31.450201Z","caller":"traceutil/trace.go:171","msg":"trace[1761966077] linearizableReadLoop","detail":"{readStateIndex:851; appliedIndex:850; }","duration":"110.529541ms","start":"2026-06-30T17:55:31.339638Z","end":"2026-06-30T17:55:31.450167Z","steps":["trace[1761966077] 'read index received' (duration: 38.331µs)","trace[1761966077] 'applied index is now lower than readState.Index' (duration: 110.48965ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:55:31.450244Z","caller":"traceutil/trace.go:171","msg":"trace[1705452988] transaction","detail":"{read_only:false; response_revision:821; number_of_response:1; }","duration":"206.887411ms","start":"2026-06-30T17:55:31.243335Z","end":"2026-06-30T17:55:31.450222Z","steps":["trace[1705452988] 'compare' (duration: 197.824963ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:55:31.451316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.671683ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:5 size:1050252"} {"level":"info","ts":"2026-06-30T17:55:31.451382Z","caller":"traceutil/trace.go:171","msg":"trace[1469229185] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:5; response_revision:821; }","duration":"111.740065ms","start":"2026-06-30T17:55:31.339624Z","end":"2026-06-30T17:55:31.451364Z","steps":["trace[1469229185] 'agreement among raft nodes before linearized reading' (duration: 110.635615ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:55:34.053131Z","caller":"traceutil/trace.go:171","msg":"trace[160117511] transaction","detail":"{read_only:false; response_revision:841; number_of_response:1; }","duration":"184.757307ms","start":"2026-06-30T17:55:33.868344Z","end":"2026-06-30T17:55:34.053102Z","steps":["trace[160117511] 'process raft request' (duration: 111.568468ms)","trace[160117511] 'compare' (duration: 72.893428ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:55:34.104449Z","caller":"traceutil/trace.go:171","msg":"trace[381313909] transaction","detail":"{read_only:false; response_revision:842; number_of_response:1; }","duration":"235.541234ms","start":"2026-06-30T17:55:33.868851Z","end":"2026-06-30T17:55:34.104392Z","steps":["trace[381313909] 'process raft request' (duration: 235.343697ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:55:34.104849Z","caller":"traceutil/trace.go:171","msg":"trace[1087794623] transaction","detail":"{read_only:false; response_revision:843; number_of_response:1; }","duration":"232.905639ms","start":"2026-06-30T17:55:33.871923Z","end":"2026-06-30T17:55:34.104828Z","steps":["trace[1087794623] 'process raft request' (duration: 232.37693ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:55:34.294559Z","caller":"traceutil/trace.go:171","msg":"trace[572392385] transaction","detail":"{read_only:false; response_revision:844; number_of_response:1; }","duration":"235.602123ms","start":"2026-06-30T17:55:34.058929Z","end":"2026-06-30T17:55:34.294531Z","steps":["trace[572392385] 'process raft request' (duration: 192.030282ms)","trace[572392385] 'compare' (duration: 43.431376ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:55:34.357295Z","caller":"traceutil/trace.go:171","msg":"trace[1549658926] transaction","detail":"{read_only:false; response_revision:846; number_of_response:1; }","duration":"217.862581ms","start":"2026-06-30T17:55:34.139407Z","end":"2026-06-30T17:55:34.35727Z","steps":["trace[1549658926] 'process raft request' (duration: 217.759377ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:55:34.357304Z","caller":"traceutil/trace.go:171","msg":"trace[1450883586] transaction","detail":"{read_only:false; response_revision:845; number_of_response:1; }","duration":"238.608989ms","start":"2026-06-30T17:55:34.118677Z","end":"2026-06-30T17:55:34.357286Z","steps":["trace[1450883586] 'process raft request' (duration: 238.35071ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:55:35.108218Z","caller":"traceutil/trace.go:171","msg":"trace[1118841468] transaction","detail":"{read_only:false; response_revision:851; number_of_response:1; }","duration":"171.350399ms","start":"2026-06-30T17:55:34.936845Z","end":"2026-06-30T17:55:35.108195Z","steps":["trace[1118841468] 'process raft request' (duration: 171.218424ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:55:35.595348Z","caller":"traceutil/trace.go:171","msg":"trace[752556024] transaction","detail":"{read_only:false; response_revision:855; number_of_response:1; }","duration":"187.276611ms","start":"2026-06-30T17:55:35.408041Z","end":"2026-06-30T17:55:35.595318Z","steps":["trace[752556024] 'process raft request' (duration: 187.083134ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:55:35.595381Z","caller":"traceutil/trace.go:171","msg":"trace[2143457289] linearizableReadLoop","detail":"{readStateIndex:886; appliedIndex:886; }","duration":"130.382216ms","start":"2026-06-30T17:55:35.464946Z","end":"2026-06-30T17:55:35.595328Z","steps":["trace[2143457289] 'read index received' (duration: 130.364086ms)","trace[2143457289] 'applied index is now lower than readState.Index' (duration: 14.98µs)"],"step_count":2} {"level":"warn","ts":"2026-06-30T17:55:35.595699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.721068ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-06-30T17:55:35.595746Z","caller":"traceutil/trace.go:171","msg":"trace[1124550068] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:855; }","duration":"130.826233ms","start":"2026-06-30T17:55:35.464904Z","end":"2026-06-30T17:55:35.59573Z","steps":["trace[1124550068] 'agreement among raft nodes before linearized reading' (duration: 130.571464ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:55:35.807232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.074282ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-30T17:55:35.807414Z","caller":"traceutil/trace.go:171","msg":"trace[1503534133] transaction","detail":"{read_only:false; response_revision:857; number_of_response:1; }","duration":"207.069342ms","start":"2026-06-30T17:55:35.600328Z","end":"2026-06-30T17:55:35.807398Z","steps":["trace[1503534133] 'process raft request' (duration: 207.00249ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:55:35.807456Z","caller":"traceutil/trace.go:171","msg":"trace[1480682115] transaction","detail":"{read_only:false; response_revision:856; number_of_response:1; }","duration":"293.199091ms","start":"2026-06-30T17:55:35.514218Z","end":"2026-06-30T17:55:35.807418Z","steps":["trace[1480682115] 'process raft request' (duration: 183.85691ms)","trace[1480682115] 'compare' (duration: 108.943507ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T17:55:42.892832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"412.904814ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T17:55:42.892914Z","caller":"traceutil/trace.go:171","msg":"trace[613965806] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:941; }","duration":"413.05934ms","start":"2026-06-30T17:55:42.479838Z","end":"2026-06-30T17:55:42.892897Z","steps":["trace[613965806] 'range keys from in-memory index tree' (duration: 412.712668ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:55:42.892958Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:55:42.479806Z","time spent":"413.143833ms","remote":"127.0.0.1:46152","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-30T17:55:42.892981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.902933ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T17:55:42.893126Z","caller":"traceutil/trace.go:171","msg":"trace[1836892844] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:941; }","duration":"380.062939ms","start":"2026-06-30T17:55:42.51304Z","end":"2026-06-30T17:55:42.893103Z","steps":["trace[1836892844] 'range keys from in-memory index tree' (duration: 379.887213ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:55:42.893327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"464.954507ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.57\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-06-30T17:55:42.893367Z","caller":"traceutil/trace.go:171","msg":"trace[1730744528] range","detail":"{range_begin:/registry/masterleases/199.204.45.57; range_end:; response_count:1; response_revision:941; }","duration":"465.021929ms","start":"2026-06-30T17:55:42.428333Z","end":"2026-06-30T17:55:42.893355Z","steps":["trace[1730744528] 'range keys from in-memory index tree' (duration: 464.809032ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:55:42.893394Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:55:42.428318Z","time spent":"465.069601ms","remote":"127.0.0.1:46186","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.204.45.57\" "} {"level":"warn","ts":"2026-06-30T17:55:42.893925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.027804ms","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-30T17:55:42.893974Z","caller":"traceutil/trace.go:171","msg":"trace[1302948532] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:941; }","duration":"101.113816ms","start":"2026-06-30T17:55:42.792846Z","end":"2026-06-30T17:55:42.89396Z","steps":["trace[1302948532] 'range keys from in-memory index tree' (duration: 100.860948ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:55:58.293848Z","caller":"traceutil/trace.go:171","msg":"trace[1461822589] transaction","detail":"{read_only:false; response_revision:1175; number_of_response:1; }","duration":"329.176179ms","start":"2026-06-30T17:55:57.964644Z","end":"2026-06-30T17:55:58.29382Z","steps":["trace[1461822589] 'process raft request' (duration: 328.983553ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:55:58.293999Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:55:57.96462Z","time spent":"329.306553ms","remote":"127.0.0.1:46376","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T17:56:13.126177Z","caller":"traceutil/trace.go:171","msg":"trace[653369003] transaction","detail":"{read_only:false; response_revision:1291; number_of_response:1; }","duration":"138.377998ms","start":"2026-06-30T17:56:12.987771Z","end":"2026-06-30T17:56:13.126149Z","steps":["trace[653369003] 'process raft request' (duration: 138.063378ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:56:21.932334Z","caller":"traceutil/trace.go:171","msg":"trace[164416108] transaction","detail":"{read_only:false; response_revision:1438; number_of_response:1; }","duration":"112.373242ms","start":"2026-06-30T17:56:21.819928Z","end":"2026-06-30T17:56:21.932301Z","steps":["trace[164416108] 'process raft request' (duration: 112.133794ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:56:22.616032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.600573ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T17:56:22.616155Z","caller":"traceutil/trace.go:171","msg":"trace[943293428] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1438; }","duration":"102.739118ms","start":"2026-06-30T17:56:22.513395Z","end":"2026-06-30T17:56:22.616134Z","steps":["trace[943293428] 'range keys from in-memory index tree' (duration: 102.585123ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:56:22.61617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.269809ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-30T17:56:22.61635Z","caller":"traceutil/trace.go:171","msg":"trace[1075203868] linearizableReadLoop","detail":"{readStateIndex:1486; appliedIndex:1485; }","duration":"136.387868ms","start":"2026-06-30T17:56:22.479945Z","end":"2026-06-30T17:56:22.616332Z","steps":["trace[1075203868] 'read index received' (duration: 14.836771ms)","trace[1075203868] 'applied index is now lower than readState.Index' (duration: 121.549337ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:56:22.616387Z","caller":"traceutil/trace.go:171","msg":"trace[1295442167] transaction","detail":"{read_only:false; response_revision:1439; number_of_response:1; }","duration":"163.083453ms","start":"2026-06-30T17:56:22.453286Z","end":"2026-06-30T17:56:22.61637Z","steps":["trace[1295442167] 'process raft request' (duration: 41.528485ms)","trace[1295442167] 'compare' (duration: 121.048432ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T17:56:22.616479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.538043ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T17:56:22.616507Z","caller":"traceutil/trace.go:171","msg":"trace[715873517] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1439; }","duration":"136.593454ms","start":"2026-06-30T17:56:22.479904Z","end":"2026-06-30T17:56:22.616498Z","steps":["trace[715873517] 'agreement among raft nodes before linearized reading' (duration: 136.516602ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:56:29.617086Z","caller":"traceutil/trace.go:171","msg":"trace[1100275046] transaction","detail":"{read_only:false; number_of_response:0; response_revision:1536; }","duration":"127.411593ms","start":"2026-06-30T17:56:29.489651Z","end":"2026-06-30T17:56:29.617063Z","steps":["trace[1100275046] 'process raft request' (duration: 127.145175ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:56:29.642946Z","caller":"traceutil/trace.go:171","msg":"trace[1421058308] transaction","detail":"{read_only:false; response_revision:1537; number_of_response:1; }","duration":"105.06373ms","start":"2026-06-30T17:56:29.537861Z","end":"2026-06-30T17:56:29.642925Z","steps":["trace[1421058308] 'process raft request' (duration: 104.859604ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:56:29.643199Z","caller":"traceutil/trace.go:171","msg":"trace[1516985669] transaction","detail":"{read_only:false; response_revision:1538; number_of_response:1; }","duration":"105.115321ms","start":"2026-06-30T17:56:29.538073Z","end":"2026-06-30T17:56:29.643188Z","steps":["trace[1516985669] 'process raft request' (duration: 104.790582ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:56:29.643512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.4532ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/ingress-nginx/ingress-nginx-defaultbackend-6987ff55cf-z7clc\" ","response":"range_response_count:1 size:4531"} {"level":"info","ts":"2026-06-30T17:56:29.643556Z","caller":"traceutil/trace.go:171","msg":"trace[1793156113] range","detail":"{range_begin:/registry/pods/ingress-nginx/ingress-nginx-defaultbackend-6987ff55cf-z7clc; range_end:; response_count:1; response_revision:1538; }","duration":"107.516211ms","start":"2026-06-30T17:56:29.536027Z","end":"2026-06-30T17:56:29.643543Z","steps":["trace[1793156113] 'agreement among raft nodes before linearized reading' (duration: 107.093419ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:56:29.752116Z","caller":"traceutil/trace.go:171","msg":"trace[364422559] transaction","detail":"{read_only:false; response_revision:1539; number_of_response:1; }","duration":"100.154507ms","start":"2026-06-30T17:56:29.651931Z","end":"2026-06-30T17:56:29.752086Z","steps":["trace[364422559] 'process raft request' (duration: 97.441488ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:56:37.231434Z","caller":"traceutil/trace.go:171","msg":"trace[1247901308] transaction","detail":"{read_only:false; response_revision:1696; number_of_response:1; }","duration":"102.254312ms","start":"2026-06-30T17:56:37.129151Z","end":"2026-06-30T17:56:37.231405Z","steps":["trace[1247901308] 'process raft request' (duration: 87.377825ms)","trace[1247901308] 'compare' (duration: 14.764664ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:56:40.224974Z","caller":"traceutil/trace.go:171","msg":"trace[1555641300] linearizableReadLoop","detail":"{readStateIndex:1805; appliedIndex:1804; }","duration":"169.081446ms","start":"2026-06-30T17:56:40.055865Z","end":"2026-06-30T17:56:40.224947Z","steps":["trace[1555641300] 'read index received' (duration: 168.86416ms)","trace[1555641300] 'applied index is now lower than readState.Index' (duration: 216.126µs)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:56:40.225017Z","caller":"traceutil/trace.go:171","msg":"trace[1181560802] transaction","detail":"{read_only:false; response_revision:1733; number_of_response:1; }","duration":"182.140607ms","start":"2026-06-30T17:56:40.042847Z","end":"2026-06-30T17:56:40.224988Z","steps":["trace[1181560802] 'process raft request' (duration: 181.948562ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:56:40.225339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.333863ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-30T17:56:40.225388Z","caller":"traceutil/trace.go:171","msg":"trace[618521428] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1733; }","duration":"169.557ms","start":"2026-06-30T17:56:40.055819Z","end":"2026-06-30T17:56:40.225376Z","steps":["trace[618521428] 'agreement among raft nodes before linearized reading' (duration: 169.22403ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:56:40.873792Z","caller":"traceutil/trace.go:171","msg":"trace[1310521789] transaction","detail":"{read_only:false; response_revision:1742; number_of_response:1; }","duration":"132.35618ms","start":"2026-06-30T17:56:40.741416Z","end":"2026-06-30T17:56:40.873772Z","steps":["trace[1310521789] 'process raft request' (duration: 132.215456ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:56:47.880768Z","caller":"traceutil/trace.go:171","msg":"trace[990771603] transaction","detail":"{read_only:false; response_revision:1847; number_of_response:1; }","duration":"100.890542ms","start":"2026-06-30T17:56:47.779821Z","end":"2026-06-30T17:56:47.880712Z","steps":["trace[990771603] 'process raft request' (duration: 100.694967ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:56:48.505529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.67267ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-30T17:56:48.505557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.184326ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-30T17:56:48.505616Z","caller":"traceutil/trace.go:171","msg":"trace[422092621] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1850; }","duration":"146.276049ms","start":"2026-06-30T17:56:48.359327Z","end":"2026-06-30T17:56:48.505603Z","steps":["trace[422092621] 'range keys from in-memory index tree' (duration: 146.059143ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:56:48.505649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.012388ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-69449bd1-2dd0-47d9-a511-3bffa09c6bb5\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-06-30T17:56:48.505633Z","caller":"traceutil/trace.go:171","msg":"trace[2022411877] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:1850; }","duration":"111.816934ms","start":"2026-06-30T17:56:48.393783Z","end":"2026-06-30T17:56:48.5056Z","steps":["trace[2022411877] 'count revisions from in-memory index tree' (duration: 111.548556ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:56:48.505729Z","caller":"traceutil/trace.go:171","msg":"trace[547083273] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-69449bd1-2dd0-47d9-a511-3bffa09c6bb5; range_end:; response_count:1; response_revision:1850; }","duration":"158.157612ms","start":"2026-06-30T17:56:48.347552Z","end":"2026-06-30T17:56:48.50571Z","steps":["trace[547083273] 'range keys from in-memory index tree' (duration: 157.815853ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:56:48.505755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.40518ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-06-30T17:56:48.505785Z","caller":"traceutil/trace.go:171","msg":"trace[1188465613] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1850; }","duration":"107.497983ms","start":"2026-06-30T17:56:48.398278Z","end":"2026-06-30T17:56:48.505776Z","steps":["trace[1188465613] 'range keys from in-memory index tree' (duration: 107.304547ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:56:48.738369Z","caller":"traceutil/trace.go:171","msg":"trace[1004068735] linearizableReadLoop","detail":"{readStateIndex:1925; appliedIndex:1924; }","duration":"190.523979ms","start":"2026-06-30T17:56:48.547829Z","end":"2026-06-30T17:56:48.738353Z","steps":["trace[1004068735] 'read index received' (duration: 190.335514ms)","trace[1004068735] 'applied index is now lower than readState.Index' (duration: 187.895µs)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:56:48.738494Z","caller":"traceutil/trace.go:171","msg":"trace[1078387246] transaction","detail":"{read_only:false; response_revision:1851; number_of_response:1; }","duration":"228.3705ms","start":"2026-06-30T17:56:48.510089Z","end":"2026-06-30T17:56:48.73846Z","steps":["trace[1078387246] 'process raft request' (duration: 228.160624ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:56:48.738714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.873009ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-69449bd1-2dd0-47d9-a511-3bffa09c6bb5\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-06-30T17:56:48.73878Z","caller":"traceutil/trace.go:171","msg":"trace[1585106248] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-69449bd1-2dd0-47d9-a511-3bffa09c6bb5; range_end:; response_count:1; response_revision:1851; }","duration":"190.986982ms","start":"2026-06-30T17:56:48.547776Z","end":"2026-06-30T17:56:48.738763Z","steps":["trace[1585106248] 'agreement among raft nodes before linearized reading' (duration: 190.756835ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:56:48.901895Z","caller":"traceutil/trace.go:171","msg":"trace[1359639064] transaction","detail":"{read_only:false; response_revision:1852; number_of_response:1; }","duration":"156.730032ms","start":"2026-06-30T17:56:48.745127Z","end":"2026-06-30T17:56:48.901857Z","steps":["trace[1359639064] 'process raft request' (duration: 91.255077ms)","trace[1359639064] 'compare' (duration: 65.353342ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:56:49.28375Z","caller":"traceutil/trace.go:171","msg":"trace[1057965883] transaction","detail":"{read_only:false; response_revision:1855; number_of_response:1; }","duration":"131.062827ms","start":"2026-06-30T17:56:49.152653Z","end":"2026-06-30T17:56:49.283716Z","steps":["trace[1057965883] 'process raft request' (duration: 103.638849ms)","trace[1057965883] 'compare' (duration: 27.068068ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T17:56:57.348602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.957445ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-30T17:56:57.348847Z","caller":"traceutil/trace.go:171","msg":"trace[1597431830] transaction","detail":"{read_only:false; response_revision:1936; number_of_response:1; }","duration":"239.992608ms","start":"2026-06-30T17:56:57.108832Z","end":"2026-06-30T17:56:57.348824Z","steps":["trace[1597431830] 'process raft request' (duration: 118.541219ms)","trace[1597431830] 'compare' (duration: 120.778241ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:57:02.315087Z","caller":"traceutil/trace.go:171","msg":"trace[1849045003] linearizableReadLoop","detail":"{readStateIndex:2044; appliedIndex:2043; }","duration":"169.619059ms","start":"2026-06-30T17:57:02.145454Z","end":"2026-06-30T17:57:02.315073Z","steps":["trace[1849045003] 'read index received' (duration: 165.776734ms)","trace[1849045003] 'applied index is now lower than readState.Index' (duration: 3.841675ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:57:02.315145Z","caller":"traceutil/trace.go:171","msg":"trace[72433445] transaction","detail":"{read_only:false; response_revision:1967; number_of_response:1; }","duration":"358.64104ms","start":"2026-06-30T17:57:01.956464Z","end":"2026-06-30T17:57:02.315106Z","steps":["trace[72433445] 'process raft request' (duration: 354.773724ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:57:02.31522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.763882ms","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-30T17:57:02.315239Z","caller":"traceutil/trace.go:171","msg":"trace[1806314618] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1967; }","duration":"169.828124ms","start":"2026-06-30T17:57:02.145405Z","end":"2026-06-30T17:57:02.315233Z","steps":["trace[1806314618] 'agreement among raft nodes before linearized reading' (duration: 169.739682ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:57:02.315277Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:57:01.956444Z","time spent":"358.762814ms","remote":"127.0.0.1:46600","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5595,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T17:57:02.315415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.964813ms","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-30T17:57:02.315458Z","caller":"traceutil/trace.go:171","msg":"trace[1293265831] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1967; }","duration":"157.022384ms","start":"2026-06-30T17:57:02.158421Z","end":"2026-06-30T17:57:02.315444Z","steps":["trace[1293265831] 'agreement among raft nodes before linearized reading' (duration: 156.88865ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:57:08.518822Z","caller":"traceutil/trace.go:171","msg":"trace[464616115] transaction","detail":"{read_only:false; response_revision:2014; number_of_response:1; }","duration":"114.590986ms","start":"2026-06-30T17:57:08.404206Z","end":"2026-06-30T17:57:08.518797Z","steps":["trace[464616115] 'process raft request' (duration: 114.407991ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:57:08.5929Z","caller":"traceutil/trace.go:171","msg":"trace[1446194493] linearizableReadLoop","detail":"{readStateIndex:2094; appliedIndex:2092; }","duration":"113.987119ms","start":"2026-06-30T17:57:08.478886Z","end":"2026-06-30T17:57:08.592873Z","steps":["trace[1446194493] 'read index received' (duration: 39.83458ms)","trace[1446194493] 'applied index is now lower than readState.Index' (duration: 74.151309ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T17:57:08.593049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.128083ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T17:57:08.593034Z","caller":"traceutil/trace.go:171","msg":"trace[1725064343] transaction","detail":"{read_only:false; response_revision:2015; number_of_response:1; }","duration":"188.57154ms","start":"2026-06-30T17:57:08.404422Z","end":"2026-06-30T17:57:08.592993Z","steps":["trace[1725064343] 'process raft request' (duration: 188.259652ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:57:08.593111Z","caller":"traceutil/trace.go:171","msg":"trace[181730066] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2015; }","duration":"114.246456ms","start":"2026-06-30T17:57:08.478848Z","end":"2026-06-30T17:57:08.593095Z","steps":["trace[181730066] 'agreement among raft nodes before linearized reading' (duration: 114.129143ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:57:08.836006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.845699ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-06-30T17:57:08.836076Z","caller":"traceutil/trace.go:171","msg":"trace[626931031] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2015; }","duration":"184.987293ms","start":"2026-06-30T17:57:08.651072Z","end":"2026-06-30T17:57:08.836059Z","steps":["trace[626931031] 'range keys from in-memory index tree' (duration: 184.658594ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:57:08.836138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.606995ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-haproxy-0\" ","response":"range_response_count:1 size:11258"} {"level":"info","ts":"2026-06-30T17:57:08.836262Z","caller":"traceutil/trace.go:171","msg":"trace[453684286] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-haproxy-0; range_end:; response_count:1; response_revision:2015; }","duration":"135.732218ms","start":"2026-06-30T17:57:08.700467Z","end":"2026-06-30T17:57:08.836199Z","steps":["trace[453684286] 'range keys from in-memory index tree' (duration: 135.448651ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:57:08.836257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.914625ms","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-30T17:57:08.836406Z","caller":"traceutil/trace.go:171","msg":"trace[1474217839] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:2015; }","duration":"225.154291ms","start":"2026-06-30T17:57:08.61123Z","end":"2026-06-30T17:57:08.836385Z","steps":["trace[1474217839] 'count revisions from in-memory index tree' (duration: 224.820712ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:57:09.224915Z","caller":"traceutil/trace.go:171","msg":"trace[1744196249] linearizableReadLoop","detail":"{readStateIndex:2095; appliedIndex:2094; }","duration":"237.605011ms","start":"2026-06-30T17:57:08.987283Z","end":"2026-06-30T17:57:09.224888Z","steps":["trace[1744196249] 'read index received' (duration: 237.362104ms)","trace[1744196249] 'applied index is now lower than readState.Index' (duration: 241.867µs)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:57:09.225033Z","caller":"traceutil/trace.go:171","msg":"trace[1966522379] transaction","detail":"{read_only:false; response_revision:2016; number_of_response:1; }","duration":"379.400023ms","start":"2026-06-30T17:57:08.845623Z","end":"2026-06-30T17:57:09.225023Z","steps":["trace[1966522379] 'process raft request' (duration: 379.024433ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:57:09.225149Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:57:08.845594Z","time spent":"379.474264ms","remote":"127.0.0.1:46316","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":11612,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T17:57:09.225242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.887838ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-30T17:57:09.225313Z","caller":"traceutil/trace.go:171","msg":"trace[55570010] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2016; }","duration":"238.023032ms","start":"2026-06-30T17:57:08.987277Z","end":"2026-06-30T17:57:09.2253Z","steps":["trace[55570010] 'agreement among raft nodes before linearized reading' (duration: 237.775845ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:57:09.386257Z","caller":"traceutil/trace.go:171","msg":"trace[1843335352] transaction","detail":"{read_only:false; response_revision:2017; number_of_response:1; }","duration":"330.647997ms","start":"2026-06-30T17:57:09.055582Z","end":"2026-06-30T17:57:09.38623Z","steps":["trace[1843335352] 'process raft request' (duration: 274.428836ms)","trace[1843335352] 'compare' (duration: 55.960834ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:57:09.386267Z","caller":"traceutil/trace.go:171","msg":"trace[1576360343] transaction","detail":"{read_only:false; response_revision:2018; number_of_response:1; }","duration":"155.415686ms","start":"2026-06-30T17:57:09.230829Z","end":"2026-06-30T17:57:09.386244Z","steps":["trace[1576360343] 'process raft request' (duration: 155.340904ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:57:09.386393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:57:09.055566Z","time spent":"330.756941ms","remote":"127.0.0.1:46376","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T17:57:09.386544Z","caller":"traceutil/trace.go:171","msg":"trace[1279611648] linearizableReadLoop","detail":"{readStateIndex:2096; appliedIndex:2095; }","duration":"161.548052ms","start":"2026-06-30T17:57:09.224985Z","end":"2026-06-30T17:57:09.386533Z","steps":["trace[1279611648] 'read index received' (duration: 105.003772ms)","trace[1279611648] 'applied index is now lower than readState.Index' (duration: 56.54332ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T17:57:09.3883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.291859ms","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-30T17:57:09.388357Z","caller":"traceutil/trace.go:171","msg":"trace[794748163] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2018; }","duration":"283.984345ms","start":"2026-06-30T17:57:09.10436Z","end":"2026-06-30T17:57:09.388344Z","steps":["trace[794748163] 'agreement among raft nodes before linearized reading' (duration: 282.218207ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:57:23.65362Z","caller":"traceutil/trace.go:171","msg":"trace[1271848730] linearizableReadLoop","detail":"{readStateIndex:2177; appliedIndex:2176; }","duration":"211.685266ms","start":"2026-06-30T17:57:23.441905Z","end":"2026-06-30T17:57:23.653591Z","steps":["trace[1271848730] 'read index received' (duration: 211.448529ms)","trace[1271848730] 'applied index is now lower than readState.Index' (duration: 235.086µs)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:57:23.653703Z","caller":"traceutil/trace.go:171","msg":"trace[1260537418] transaction","detail":"{read_only:false; response_revision:2095; number_of_response:1; }","duration":"220.119819ms","start":"2026-06-30T17:57:23.433555Z","end":"2026-06-30T17:57:23.653674Z","steps":["trace[1260537418] 'process raft request' (duration: 219.854652ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:57:23.653915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.993533ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-30T17:57:23.65396Z","caller":"traceutil/trace.go:171","msg":"trace[1069144121] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2095; }","duration":"212.106066ms","start":"2026-06-30T17:57:23.441843Z","end":"2026-06-30T17:57:23.653949Z","steps":["trace[1069144121] 'agreement among raft nodes before linearized reading' (duration: 211.922391ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:57:23.664262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.204946ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-06-30T17:57:23.664436Z","caller":"traceutil/trace.go:171","msg":"trace[1473078345] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2096; }","duration":"204.443783ms","start":"2026-06-30T17:57:23.459964Z","end":"2026-06-30T17:57:23.664407Z","steps":["trace[1473078345] 'agreement among raft nodes before linearized reading' (duration: 204.139105ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:57:23.664741Z","caller":"traceutil/trace.go:171","msg":"trace[750978807] transaction","detail":"{read_only:false; response_revision:2096; number_of_response:1; }","duration":"127.682373ms","start":"2026-06-30T17:57:23.53702Z","end":"2026-06-30T17:57:23.664702Z","steps":["trace[750978807] 'process raft request' (duration: 126.315337ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:57:23.976532Z","caller":"traceutil/trace.go:171","msg":"trace[1989301242] transaction","detail":"{read_only:false; response_revision:2100; number_of_response:1; }","duration":"306.915286ms","start":"2026-06-30T17:57:23.669598Z","end":"2026-06-30T17:57:23.976513Z","steps":["trace[1989301242] 'process raft request' (duration: 306.829024ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:57:23.97653Z","caller":"traceutil/trace.go:171","msg":"trace[34587636] transaction","detail":"{read_only:false; response_revision:2098; number_of_response:1; }","duration":"311.056646ms","start":"2026-06-30T17:57:23.66542Z","end":"2026-06-30T17:57:23.976476Z","steps":["trace[34587636] 'process raft request' (duration: 294.494306ms)","trace[34587636] 'compare' (duration: 16.278672ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:57:23.976717Z","caller":"traceutil/trace.go:171","msg":"trace[530101046] linearizableReadLoop","detail":"{readStateIndex:2183; appliedIndex:2179; }","duration":"191.832838ms","start":"2026-06-30T17:57:23.784861Z","end":"2026-06-30T17:57:23.976694Z","steps":["trace[530101046] 'read index received' (duration: 174.99572ms)","trace[530101046] 'applied index is now lower than readState.Index' (duration: 16.835738ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:57:23.976535Z","caller":"traceutil/trace.go:171","msg":"trace[981930517] transaction","detail":"{read_only:false; response_revision:2099; number_of_response:1; }","duration":"307.305716ms","start":"2026-06-30T17:57:23.669202Z","end":"2026-06-30T17:57:23.976508Z","steps":["trace[981930517] 'process raft request' (duration: 307.160642ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:57:23.976895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:57:23.669176Z","time spent":"307.620725ms","remote":"127.0.0.1:46376","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":539,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T17:57:23.977077Z","caller":"traceutil/trace.go:171","msg":"trace[157726457] transaction","detail":"{read_only:false; response_revision:2101; number_of_response:1; }","duration":"305.743805ms","start":"2026-06-30T17:57:23.67128Z","end":"2026-06-30T17:57:23.977023Z","steps":["trace[157726457] 'process raft request' (duration: 305.18148ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:57:23.977303Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:57:23.67127Z","time spent":"305.923939ms","remote":"127.0.0.1:46376","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T17:57:23.977375Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:57:23.669588Z","time spent":"307.022229ms","remote":"127.0.0.1:46376","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-30T17:57:23.977516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.642769ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-30T17:57:23.977599Z","caller":"traceutil/trace.go:171","msg":"trace[1089586535] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:2101; }","duration":"192.776462ms","start":"2026-06-30T17:57:23.78481Z","end":"2026-06-30T17:57:23.977586Z","steps":["trace[1089586535] 'agreement among raft nodes before linearized reading' (duration: 192.025753ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:57:23.97765Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:57:23.665412Z","time spent":"311.21778ms","remote":"127.0.0.1:46220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":819,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-30T17:57:24.402434Z","caller":"traceutil/trace.go:171","msg":"trace[585450329] transaction","detail":"{read_only:false; response_revision:2102; number_of_response:1; }","duration":"303.964918ms","start":"2026-06-30T17:57:24.098437Z","end":"2026-06-30T17:57:24.402402Z","steps":["trace[585450329] 'process raft request' (duration: 219.875856ms)","trace[585450329] 'compare' (duration: 83.953179ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T17:57:24.402572Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:57:24.098407Z","time spent":"304.096272ms","remote":"127.0.0.1:46376","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T17:57:25.175187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"512.369304ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-30T17:57:25.175387Z","caller":"traceutil/trace.go:171","msg":"trace[53392583] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2102; }","duration":"512.625261ms","start":"2026-06-30T17:57:24.662738Z","end":"2026-06-30T17:57:25.175363Z","steps":["trace[53392583] 'range keys from in-memory index tree' (duration: 512.120368ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:57:25.175431Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"590.654413ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-30T17:57:25.175528Z","caller":"traceutil/trace.go:171","msg":"trace[1606932674] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2102; }","duration":"590.797867ms","start":"2026-06-30T17:57:24.58471Z","end":"2026-06-30T17:57:25.175508Z","steps":["trace[1606932674] 'range keys from in-memory index tree' (duration: 590.374025ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:57:25.175554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.79861ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-06-30T17:57:25.175638Z","caller":"traceutil/trace.go:171","msg":"trace[1659741474] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2102; }","duration":"190.932603ms","start":"2026-06-30T17:57:24.984686Z","end":"2026-06-30T17:57:25.175618Z","steps":["trace[1659741474] 'range keys from in-memory index tree' (duration: 190.620665ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:57:25.175585Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:57:24.584689Z","time spent":"590.884769ms","remote":"127.0.0.1:46376","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-30T17:57:25.175643Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:57:24.662715Z","time spent":"512.784446ms","remote":"127.0.0.1:46376","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-30T17:57:25.176783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"661.827932ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T17:57:25.177032Z","caller":"traceutil/trace.go:171","msg":"trace[82113879] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:2102; }","duration":"663.174228ms","start":"2026-06-30T17:57:24.51383Z","end":"2026-06-30T17:57:25.177005Z","steps":["trace[82113879] 'count revisions from in-memory index tree' (duration: 660.907247ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:57:25.177185Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:57:24.513815Z","time spent":"663.345682ms","remote":"127.0.0.1:50524","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true "} {"level":"info","ts":"2026-06-30T17:57:25.589704Z","caller":"traceutil/trace.go:171","msg":"trace[899958289] transaction","detail":"{read_only:false; response_revision:2103; number_of_response:1; }","duration":"408.324826ms","start":"2026-06-30T17:57:25.181356Z","end":"2026-06-30T17:57:25.589681Z","steps":["trace[899958289] 'process raft request' (duration: 408.186652ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:57:25.589859Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:57:25.181339Z","time spent":"408.441658ms","remote":"127.0.0.1:46376","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-30T17:57:25.598916Z","caller":"traceutil/trace.go:171","msg":"trace[73974364] transaction","detail":"{read_only:false; response_revision:2104; number_of_response:1; }","duration":"417.375596ms","start":"2026-06-30T17:57:25.181515Z","end":"2026-06-30T17:57:25.598891Z","steps":["trace[73974364] 'process raft request' (duration: 417.199181ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:57:25.599006Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:57:25.181492Z","time spent":"417.474388ms","remote":"127.0.0.1:46376","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T17:57:25.59904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.20368ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T17:57:25.599106Z","caller":"traceutil/trace.go:171","msg":"trace[1012765158] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2104; }","duration":"119.313343ms","start":"2026-06-30T17:57:25.479777Z","end":"2026-06-30T17:57:25.599091Z","steps":["trace[1012765158] 'agreement among raft nodes before linearized reading' (duration: 119.17139ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:57:25.598892Z","caller":"traceutil/trace.go:171","msg":"trace[472595283] linearizableReadLoop","detail":"{readStateIndex:2186; appliedIndex:2184; }","duration":"119.044436ms","start":"2026-06-30T17:57:25.479819Z","end":"2026-06-30T17:57:25.598864Z","steps":["trace[472595283] 'read index received' (duration: 109.731539ms)","trace[472595283] 'applied index is now lower than readState.Index' (duration: 9.311637ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:57:26.139208Z","caller":"traceutil/trace.go:171","msg":"trace[286705593] transaction","detail":"{read_only:false; response_revision:2105; number_of_response:1; }","duration":"529.704719ms","start":"2026-06-30T17:57:25.609474Z","end":"2026-06-30T17:57:26.139179Z","steps":["trace[286705593] 'process raft request' (duration: 523.473094ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:57:26.139372Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:57:25.609461Z","time spent":"529.822943ms","remote":"127.0.0.1:46376","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T17:57:26.139971Z","caller":"traceutil/trace.go:171","msg":"trace[1579274318] transaction","detail":"{read_only:false; response_revision:2106; number_of_response:1; }","duration":"480.201537ms","start":"2026-06-30T17:57:25.659726Z","end":"2026-06-30T17:57:26.139927Z","steps":["trace[1579274318] 'process raft request' (duration: 479.345025ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:57:26.140334Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:57:25.659697Z","time spent":"480.588618ms","remote":"127.0.0.1:46376","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T17:57:26.140085Z","caller":"traceutil/trace.go:171","msg":"trace[667620587] linearizableReadLoop","detail":"{readStateIndex:2189; appliedIndex:2186; }","duration":"382.97436ms","start":"2026-06-30T17:57:25.757098Z","end":"2026-06-30T17:57:26.140073Z","steps":["trace[667620587] 'read index received' (duration: 375.711428ms)","trace[667620587] 'applied index is now lower than readState.Index' (duration: 7.262052ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T17:57:26.140215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"383.114234ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-30T17:57:26.140687Z","caller":"traceutil/trace.go:171","msg":"trace[21508718] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2107; }","duration":"383.575816ms","start":"2026-06-30T17:57:25.757057Z","end":"2026-06-30T17:57:26.140633Z","steps":["trace[21508718] 'agreement among raft nodes before linearized reading' (duration: 383.050692ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:57:26.140757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.051763ms","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-30T17:57:26.140806Z","caller":"traceutil/trace.go:171","msg":"trace[1575831586] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2107; }","duration":"159.140755ms","start":"2026-06-30T17:57:25.981652Z","end":"2026-06-30T17:57:26.140793Z","steps":["trace[1575831586] 'agreement among raft nodes before linearized reading' (duration: 159.017172ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:57:26.140884Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:57:25.756999Z","time spent":"383.774571ms","remote":"127.0.0.1:46376","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":"warn","ts":"2026-06-30T17:57:26.141022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.297783ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-06-30T17:57:26.141094Z","caller":"traceutil/trace.go:171","msg":"trace[1432587385] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2107; }","duration":"158.393966ms","start":"2026-06-30T17:57:25.98268Z","end":"2026-06-30T17:57:26.141073Z","steps":["trace[1432587385] 'agreement among raft nodes before linearized reading' (duration: 158.277322ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:57:26.140192Z","caller":"traceutil/trace.go:171","msg":"trace[1763052785] transaction","detail":"{read_only:false; response_revision:2107; number_of_response:1; }","duration":"464.792969ms","start":"2026-06-30T17:57:25.675347Z","end":"2026-06-30T17:57:26.14014Z","steps":["trace[1763052785] 'process raft request' (duration: 464.495021ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:57:26.141401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.586127ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:554"} {"level":"info","ts":"2026-06-30T17:57:26.141465Z","caller":"traceutil/trace.go:171","msg":"trace[1292173937] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2107; }","duration":"159.70167ms","start":"2026-06-30T17:57:25.981747Z","end":"2026-06-30T17:57:26.141449Z","steps":["trace[1292173937] 'agreement among raft nodes before linearized reading' (duration: 159.514866ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:57:26.141454Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:57:25.675332Z","time spent":"465.953819ms","remote":"127.0.0.1:46376","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T17:58:18.129938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.111619ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:530"} {"level":"info","ts":"2026-06-30T17:58:18.130028Z","caller":"traceutil/trace.go:171","msg":"trace[1248424538] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:2434; }","duration":"128.241951ms","start":"2026-06-30T17:58:18.001768Z","end":"2026-06-30T17:58:18.13001Z","steps":["trace[1248424538] 'range keys from in-memory index tree' (duration: 127.958624ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:58:18.130347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.40709ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/memcached-memcached-6479589586-4lgkg\" ","response":"range_response_count:1 size:7817"} {"level":"info","ts":"2026-06-30T17:58:18.130426Z","caller":"traceutil/trace.go:171","msg":"trace[1995185672] range","detail":"{range_begin:/registry/pods/openstack/memcached-memcached-6479589586-4lgkg; range_end:; response_count:1; response_revision:2434; }","duration":"127.510693ms","start":"2026-06-30T17:58:18.002897Z","end":"2026-06-30T17:58:18.130407Z","steps":["trace[1995185672] 'range keys from in-memory index tree' (duration: 127.269207ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:58:27.188794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"517.2648ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-30T17:58:27.188872Z","caller":"traceutil/trace.go:171","msg":"trace[1277555056] linearizableReadLoop","detail":"{readStateIndex:2638; appliedIndex:2637; }","duration":"483.426153ms","start":"2026-06-30T17:58:26.705436Z","end":"2026-06-30T17:58:27.188862Z","steps":["trace[1277555056] 'read index received' (duration: 42.651µs)","trace[1277555056] 'applied index is now lower than readState.Index' (duration: 483.382762ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T17:58:27.188972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"483.545646ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"info","ts":"2026-06-30T17:58:27.188986Z","caller":"traceutil/trace.go:171","msg":"trace[319950850] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2542; }","duration":"483.609368ms","start":"2026-06-30T17:58:26.705371Z","end":"2026-06-30T17:58:27.188981Z","steps":["trace[319950850] 'agreement among raft nodes before linearized reading' (duration: 483.515296ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:58:27.189004Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:58:26.705353Z","time spent":"483.645439ms","remote":"127.0.0.1:46326","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":1392,"request content":"key:\"/registry/services/specs/auth-system/keycloak-headless\" "} {"level":"info","ts":"2026-06-30T17:58:27.189066Z","caller":"traceutil/trace.go:171","msg":"trace[1559491483] transaction","detail":"{read_only:false; response_revision:2542; number_of_response:1; }","duration":"565.506793ms","start":"2026-06-30T17:58:26.623527Z","end":"2026-06-30T17:58:27.189034Z","steps":["trace[1559491483] 'process raft request' (duration: 47.954565ms)","trace[1559491483] 'compare' (duration: 517.018164ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T17:58:27.189202Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:58:26.623494Z","time spent":"565.636716ms","remote":"127.0.0.1:46376","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T17:58:59.542709Z","caller":"traceutil/trace.go:171","msg":"trace[1256496918] transaction","detail":"{read_only:false; response_revision:2721; number_of_response:1; }","duration":"324.657617ms","start":"2026-06-30T17:58:59.218029Z","end":"2026-06-30T17:58:59.542687Z","steps":["trace[1256496918] 'process raft request' (duration: 324.510433ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:58:59.543637Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:58:59.217997Z","time spent":"324.79506ms","remote":"127.0.0.1:46376","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T17:58:59.552268Z","caller":"traceutil/trace.go:171","msg":"trace[1268385538] linearizableReadLoop","detail":"{readStateIndex:2826; appliedIndex:2825; }","duration":"206.760076ms","start":"2026-06-30T17:58:59.345485Z","end":"2026-06-30T17:58:59.552245Z","steps":["trace[1268385538] 'read index received' (duration: 197.258758ms)","trace[1268385538] 'applied index is now lower than readState.Index' (duration: 9.500378ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:58:59.552468Z","caller":"traceutil/trace.go:171","msg":"trace[1791823909] transaction","detail":"{read_only:false; response_revision:2722; number_of_response:1; }","duration":"257.27679ms","start":"2026-06-30T17:58:59.295174Z","end":"2026-06-30T17:58:59.55245Z","steps":["trace[1791823909] 'process raft request' (duration: 256.937702ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:58:59.552636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.112855ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T17:58:59.552768Z","caller":"traceutil/trace.go:171","msg":"trace[852287098] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:2722; }","duration":"207.286969ms","start":"2026-06-30T17:58:59.345453Z","end":"2026-06-30T17:58:59.55274Z","steps":["trace[852287098] 'agreement among raft nodes before linearized reading' (duration: 207.074984ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:59:00.127235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"484.853397ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T17:59:00.127332Z","caller":"traceutil/trace.go:171","msg":"trace[1458440038] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:2722; }","duration":"485.010621ms","start":"2026-06-30T17:58:59.642299Z","end":"2026-06-30T17:59:00.12731Z","steps":["trace[1458440038] 'range keys from in-memory index tree' (duration: 484.777716ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:59:00.127374Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:58:59.642277Z","time spent":"485.088524ms","remote":"127.0.0.1:46572","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":28,"request content":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" "} {"level":"warn","ts":"2026-06-30T17:59:00.127749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.232819ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/auth-system/keycloak-0.18bdeda4e605ce34\" ","response":"range_response_count:1 size:781"} {"level":"info","ts":"2026-06-30T17:59:00.127822Z","caller":"traceutil/trace.go:171","msg":"trace[1121720961] range","detail":"{range_begin:/registry/events/auth-system/keycloak-0.18bdeda4e605ce34; range_end:; response_count:1; response_revision:2722; }","duration":"124.372393ms","start":"2026-06-30T17:59:00.003432Z","end":"2026-06-30T17:59:00.127805Z","steps":["trace[1121720961] 'range keys from in-memory index tree' (duration: 124.035654ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:59:00.359214Z","caller":"traceutil/trace.go:171","msg":"trace[65110643] transaction","detail":"{read_only:false; response_revision:2723; number_of_response:1; }","duration":"226.94177ms","start":"2026-06-30T17:59:00.132241Z","end":"2026-06-30T17:59:00.359183Z","steps":["trace[65110643] 'process raft request' (duration: 226.695084ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:59:00.359254Z","caller":"traceutil/trace.go:171","msg":"trace[211317736] linearizableReadLoop","detail":"{readStateIndex:2827; appliedIndex:2827; }","duration":"226.343486ms","start":"2026-06-30T17:59:00.132862Z","end":"2026-06-30T17:59:00.359205Z","steps":["trace[211317736] 'read index received' (duration: 226.318215ms)","trace[211317736] 'applied index is now lower than readState.Index' (duration: 21.19µs)"],"step_count":2} {"level":"warn","ts":"2026-06-30T17:59:00.35953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.630613ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T17:59:00.359643Z","caller":"traceutil/trace.go:171","msg":"trace[521790607] range","detail":"{range_begin:/registry/services/specs/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:2723; }","duration":"226.803427ms","start":"2026-06-30T17:59:00.132814Z","end":"2026-06-30T17:59:00.359617Z","steps":["trace[521790607] 'agreement among raft nodes before linearized reading' (duration: 226.51954ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T17:59:00.497911Z","caller":"traceutil/trace.go:171","msg":"trace[284570806] transaction","detail":"{read_only:false; response_revision:2724; number_of_response:1; }","duration":"364.958605ms","start":"2026-06-30T17:59:00.132922Z","end":"2026-06-30T17:59:00.497881Z","steps":["trace[284570806] 'process raft request' (duration: 340.613865ms)","trace[284570806] 'compare' (duration: 24.041652ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T17:59:00.498087Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:59:00.132903Z","time spent":"365.097449ms","remote":"127.0.0.1:46376","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T17:59:00.498128Z","caller":"traceutil/trace.go:171","msg":"trace[467178962] linearizableReadLoop","detail":"{readStateIndex:2829; appliedIndex:2827; }","duration":"131.012079ms","start":"2026-06-30T17:59:00.367077Z","end":"2026-06-30T17:59:00.49809Z","steps":["trace[467178962] 'read index received' (duration: 106.376142ms)","trace[467178962] 'applied index is now lower than readState.Index' (duration: 24.633107ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T17:59:00.498269Z","caller":"traceutil/trace.go:171","msg":"trace[702336863] transaction","detail":"{read_only:false; response_revision:2725; number_of_response:1; }","duration":"365.247082ms","start":"2026-06-30T17:59:00.133011Z","end":"2026-06-30T17:59:00.498258Z","steps":["trace[702336863] 'process raft request' (duration: 364.77367ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:59:00.498292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.204154ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12212"} {"level":"info","ts":"2026-06-30T17:59:00.49832Z","caller":"traceutil/trace.go:171","msg":"trace[125498247] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2725; }","duration":"131.276075ms","start":"2026-06-30T17:59:00.367035Z","end":"2026-06-30T17:59:00.498311Z","steps":["trace[125498247] 'agreement among raft nodes before linearized reading' (duration: 131.151432ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T17:59:00.49833Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T17:59:00.132995Z","time spent":"365.307613ms","remote":"127.0.0.1:46376","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T18:02:04.133183Z","caller":"traceutil/trace.go:171","msg":"trace[2057834191] linearizableReadLoop","detail":"{readStateIndex:4004; appliedIndex:4003; }","duration":"100.351187ms","start":"2026-06-30T18:02:04.032806Z","end":"2026-06-30T18:02:04.133157Z","steps":["trace[2057834191] 'read index received' (duration: 94.063302ms)","trace[2057834191] 'applied index is now lower than readState.Index' (duration: 6.284115ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T18:02:04.133278Z","caller":"traceutil/trace.go:171","msg":"trace[1571243595] transaction","detail":"{read_only:false; response_revision:3854; number_of_response:1; }","duration":"181.073783ms","start":"2026-06-30T18:02:03.952167Z","end":"2026-06-30T18:02:04.133241Z","steps":["trace[1571243595] 'process raft request' (duration: 175.401213ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:02:04.133371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.549532ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/rsakeys/\" range_end:\"/registry/secretgen.k14s.io/rsakeys0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T18:02:04.133409Z","caller":"traceutil/trace.go:171","msg":"trace[2129595597] range","detail":"{range_begin:/registry/secretgen.k14s.io/rsakeys/; range_end:/registry/secretgen.k14s.io/rsakeys0; response_count:0; response_revision:3854; }","duration":"100.648905ms","start":"2026-06-30T18:02:04.032748Z","end":"2026-06-30T18:02:04.133397Z","steps":["trace[2129595597] 'agreement among raft nodes before linearized reading' (duration: 100.541812ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:02:20.661045Z","caller":"traceutil/trace.go:171","msg":"trace[1365878569] transaction","detail":"{read_only:false; number_of_response:0; response_revision:3948; }","duration":"100.150172ms","start":"2026-06-30T18:02:20.560874Z","end":"2026-06-30T18:02:20.661024Z","steps":["trace[1365878569] 'process raft request' (duration: 99.845624ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:02:41.998453Z","caller":"traceutil/trace.go:171","msg":"trace[186876127] linearizableReadLoop","detail":"{readStateIndex:4504; appliedIndex:4503; }","duration":"104.52681ms","start":"2026-06-30T18:02:41.893907Z","end":"2026-06-30T18:02:41.998433Z","steps":["trace[186876127] 'read index received' (duration: 104.10643ms)","trace[186876127] 'applied index is now lower than readState.Index' (duration: 419.49µs)"],"step_count":2} {"level":"info","ts":"2026-06-30T18:02:41.998526Z","caller":"traceutil/trace.go:171","msg":"trace[1877082788] transaction","detail":"{read_only:false; response_revision:4333; number_of_response:1; }","duration":"108.061987ms","start":"2026-06-30T18:02:41.890414Z","end":"2026-06-30T18:02:41.998476Z","steps":["trace[1877082788] 'process raft request' (duration: 107.698458ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:02:41.999275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.34515ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/grafana-tls\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T18:02:41.999404Z","caller":"traceutil/trace.go:171","msg":"trace[1737281576] range","detail":"{range_begin:/registry/secrets/monitoring/grafana-tls; range_end:; response_count:0; response_revision:4333; }","duration":"105.494054ms","start":"2026-06-30T18:02:41.893863Z","end":"2026-06-30T18:02:41.999357Z","steps":["trace[1737281576] 'agreement among raft nodes before linearized reading' (duration: 104.646523ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:02:42.020951Z","caller":"traceutil/trace.go:171","msg":"trace[265996026] transaction","detail":"{read_only:false; response_revision:4334; number_of_response:1; }","duration":"122.176044ms","start":"2026-06-30T18:02:41.898754Z","end":"2026-06-30T18:02:42.02093Z","steps":["trace[265996026] 'process raft request' (duration: 121.948419ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:02:42.020977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.284313ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/monitoring/alertmanager-tls\" ","response":"range_response_count:1 size:2892"} {"level":"info","ts":"2026-06-30T18:02:42.021035Z","caller":"traceutil/trace.go:171","msg":"trace[1426503208] range","detail":"{range_begin:/registry/cert-manager.io/certificates/monitoring/alertmanager-tls; range_end:; response_count:1; response_revision:4335; }","duration":"119.370364ms","start":"2026-06-30T18:02:41.901649Z","end":"2026-06-30T18:02:42.02102Z","steps":["trace[1426503208] 'agreement among raft nodes before linearized reading' (duration: 119.20597ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:02:42.146607Z","caller":"traceutil/trace.go:171","msg":"trace[1280274904] linearizableReadLoop","detail":"{readStateIndex:4508; appliedIndex:4506; }","duration":"125.747281ms","start":"2026-06-30T18:02:42.020836Z","end":"2026-06-30T18:02:42.146583Z","steps":["trace[1280274904] 'read index received' (duration: 93.108029ms)","trace[1280274904] 'applied index is now lower than readState.Index' (duration: 32.638292ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T18:02:42.146723Z","caller":"traceutil/trace.go:171","msg":"trace[1377254868] transaction","detail":"{read_only:false; response_revision:4337; number_of_response:1; }","duration":"129.417321ms","start":"2026-06-30T18:02:42.017295Z","end":"2026-06-30T18:02:42.146713Z","steps":["trace[1377254868] 'process raft request' (duration: 129.191816ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:02:42.146825Z","caller":"traceutil/trace.go:171","msg":"trace[1197413777] transaction","detail":"{read_only:false; response_revision:4336; number_of_response:1; }","duration":"135.974903ms","start":"2026-06-30T18:02:42.010824Z","end":"2026-06-30T18:02:42.146799Z","steps":["trace[1197413777] 'process raft request' (duration: 103.122385ms)","trace[1197413777] 'compare' (duration: 32.379976ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T18:02:42.147038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.227823ms","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-30T18:02:42.147261Z","caller":"traceutil/trace.go:171","msg":"trace[1355320465] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4337; }","duration":"139.476679ms","start":"2026-06-30T18:02:42.00774Z","end":"2026-06-30T18:02:42.147217Z","steps":["trace[1355320465] 'agreement among raft nodes before linearized reading' (duration: 139.179501ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:02:42.149336Z","caller":"traceutil/trace.go:171","msg":"trace[411181466] transaction","detail":"{read_only:false; response_revision:4339; number_of_response:1; }","duration":"120.499742ms","start":"2026-06-30T18:02:42.028816Z","end":"2026-06-30T18:02:42.149315Z","steps":["trace[411181466] 'process raft request' (duration: 120.140774ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:02:42.149778Z","caller":"traceutil/trace.go:171","msg":"trace[387937027] transaction","detail":"{read_only:false; response_revision:4341; number_of_response:1; }","duration":"115.495389ms","start":"2026-06-30T18:02:42.03427Z","end":"2026-06-30T18:02:42.149765Z","steps":["trace[387937027] 'process raft request' (duration: 114.780032ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:02:42.14994Z","caller":"traceutil/trace.go:171","msg":"trace[822981876] transaction","detail":"{read_only:false; response_revision:4338; number_of_response:1; }","duration":"125.406883ms","start":"2026-06-30T18:02:42.024519Z","end":"2026-06-30T18:02:42.149926Z","steps":["trace[822981876] 'process raft request' (duration: 124.362318ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:02:42.15011Z","caller":"traceutil/trace.go:171","msg":"trace[391263952] transaction","detail":"{read_only:false; response_revision:4340; number_of_response:1; }","duration":"117.14501ms","start":"2026-06-30T18:02:42.032958Z","end":"2026-06-30T18:02:42.150103Z","steps":["trace[391263952] 'process raft request' (duration: 116.041913ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:02:42.15042Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.479191ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:554"} {"level":"info","ts":"2026-06-30T18:02:42.150502Z","caller":"traceutil/trace.go:171","msg":"trace[742309158] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4341; }","duration":"100.597753ms","start":"2026-06-30T18:02:42.049885Z","end":"2026-06-30T18:02:42.150483Z","steps":["trace[742309158] 'agreement among raft nodes before linearized reading' (duration: 100.04764ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:02:42.151316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.685187ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-06-30T18:02:42.151552Z","caller":"traceutil/trace.go:171","msg":"trace[742696625] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4341; }","duration":"122.962673ms","start":"2026-06-30T18:02:42.02857Z","end":"2026-06-30T18:02:42.151533Z","steps":["trace[742696625] 'agreement among raft nodes before linearized reading' (duration: 120.521733ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:02:42.152014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.274187ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/sshkeys/\" range_end:\"/registry/secretgen.k14s.io/sshkeys0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T18:02:42.152241Z","caller":"traceutil/trace.go:171","msg":"trace[736654935] range","detail":"{range_begin:/registry/secretgen.k14s.io/sshkeys/; range_end:/registry/secretgen.k14s.io/sshkeys0; response_count:0; response_revision:4341; }","duration":"109.463471ms","start":"2026-06-30T18:02:42.042682Z","end":"2026-06-30T18:02:42.152146Z","steps":["trace[736654935] 'agreement among raft nodes before linearized reading' (duration: 107.515853ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:02:47.469672Z","caller":"traceutil/trace.go:171","msg":"trace[1227060198] transaction","detail":"{read_only:false; number_of_response:1; response_revision:4534; }","duration":"126.168802ms","start":"2026-06-30T18:02:47.343484Z","end":"2026-06-30T18:02:47.469653Z","steps":["trace[1227060198] 'process raft request' (duration: 60.693432ms)","trace[1227060198] 'compare' (duration: 65.164232ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T18:02:52.26879Z","caller":"traceutil/trace.go:171","msg":"trace[1579577673] transaction","detail":"{read_only:false; response_revision:4637; number_of_response:1; }","duration":"277.938533ms","start":"2026-06-30T18:02:51.990829Z","end":"2026-06-30T18:02:52.268767Z","steps":["trace[1579577673] 'process raft request' (duration: 277.755219ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:02:52.269287Z","caller":"traceutil/trace.go:171","msg":"trace[1520292511] transaction","detail":"{read_only:false; response_revision:4638; number_of_response:1; }","duration":"278.355464ms","start":"2026-06-30T18:02:51.990919Z","end":"2026-06-30T18:02:52.269274Z","steps":["trace[1520292511] 'process raft request' (duration: 277.78972ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:02:52.270666Z","caller":"traceutil/trace.go:171","msg":"trace[1652432350] transaction","detail":"{read_only:false; response_revision:4639; number_of_response:1; }","duration":"275.536324ms","start":"2026-06-30T18:02:51.995116Z","end":"2026-06-30T18:02:52.270652Z","steps":["trace[1652432350] 'process raft request' (duration: 273.973366ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:02:52.270653Z","caller":"traceutil/trace.go:171","msg":"trace[976021102] linearizableReadLoop","detail":"{readStateIndex:4818; appliedIndex:4815; }","duration":"203.853142ms","start":"2026-06-30T18:02:52.066778Z","end":"2026-06-30T18:02:52.270631Z","steps":["trace[976021102] 'read index received' (duration: 201.782201ms)","trace[976021102] 'applied index is now lower than readState.Index' (duration: 2.069561ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T18:02:52.270888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.046937ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/prometheus-operated\" ","response":"range_response_count:1 size:993"} {"level":"info","ts":"2026-06-30T18:02:52.270933Z","caller":"traceutil/trace.go:171","msg":"trace[1238557423] range","detail":"{range_begin:/registry/services/specs/monitoring/prometheus-operated; range_end:; response_count:1; response_revision:4639; }","duration":"204.17085ms","start":"2026-06-30T18:02:52.066754Z","end":"2026-06-30T18:02:52.270924Z","steps":["trace[1238557423] 'agreement among raft nodes before linearized reading' (duration: 203.947225ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:02:53.520419Z","caller":"traceutil/trace.go:171","msg":"trace[1383495624] transaction","detail":"{read_only:false; response_revision:4652; number_of_response:1; }","duration":"185.497941ms","start":"2026-06-30T18:02:53.334893Z","end":"2026-06-30T18:02:53.52039Z","steps":["trace[1383495624] 'process raft request' (duration: 165.750435ms)","trace[1383495624] 'compare' (duration: 19.594602ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T18:02:57.954188Z","caller":"traceutil/trace.go:171","msg":"trace[923404978] transaction","detail":"{read_only:false; response_revision:4731; number_of_response:1; }","duration":"191.502298ms","start":"2026-06-30T18:02:57.762663Z","end":"2026-06-30T18:02:57.954165Z","steps":["trace[923404978] 'process raft request' (duration: 191.299273ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:02:58.583334Z","caller":"traceutil/trace.go:171","msg":"trace[959895055] linearizableReadLoop","detail":"{readStateIndex:4914; appliedIndex:4912; }","duration":"740.754812ms","start":"2026-06-30T18:02:57.842552Z","end":"2026-06-30T18:02:58.583307Z","steps":["trace[959895055] 'read index received' (duration: 111.474171ms)","trace[959895055] 'applied index is now lower than readState.Index' (duration: 629.279731ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T18:02:58.583382Z","caller":"traceutil/trace.go:171","msg":"trace[784986529] transaction","detail":"{read_only:false; response_revision:4732; number_of_response:1; }","duration":"780.91995ms","start":"2026-06-30T18:02:57.802421Z","end":"2026-06-30T18:02:58.583341Z","steps":["trace[784986529] 'process raft request' (duration: 780.437178ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:02:58.583425Z","caller":"traceutil/trace.go:171","msg":"trace[1239389392] transaction","detail":"{read_only:false; response_revision:4733; number_of_response:1; }","duration":"658.336226ms","start":"2026-06-30T18:02:57.925055Z","end":"2026-06-30T18:02:58.583392Z","steps":["trace[1239389392] 'process raft request' (duration: 658.178453ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:02:58.583538Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T18:02:57.802393Z","time spent":"781.057973ms","remote":"127.0.0.1:46376","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-30T18:02:58.583557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"740.985598ms","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:7"} {"level":"info","ts":"2026-06-30T18:02:58.583744Z","caller":"traceutil/trace.go:171","msg":"trace[229765932] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:4733; }","duration":"741.226514ms","start":"2026-06-30T18:02:57.842496Z","end":"2026-06-30T18:02:58.583723Z","steps":["trace[229765932] 'agreement among raft nodes before linearized reading' (duration: 740.991568ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:02:58.5838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"634.48935ms","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-30T18:02:58.583808Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T18:02:57.925035Z","time spent":"658.446939ms","remote":"127.0.0.1:46376","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T18:02:58.583851Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T18:02:57.84247Z","time spent":"741.358427ms","remote":"127.0.0.1:40488","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":30,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "} {"level":"info","ts":"2026-06-30T18:02:58.583874Z","caller":"traceutil/trace.go:171","msg":"trace[745256890] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4733; }","duration":"634.604412ms","start":"2026-06-30T18:02:57.949251Z","end":"2026-06-30T18:02:58.583855Z","steps":["trace[745256890] 'agreement among raft nodes before linearized reading' (duration: 634.396227ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:02:58.583921Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T18:02:57.949238Z","time spent":"634.673604ms","remote":"127.0.0.1:46376","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-30T18:02:58.583994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.576497ms","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-30T18:02:58.584047Z","caller":"traceutil/trace.go:171","msg":"trace[1011938837] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4733; }","duration":"258.647299ms","start":"2026-06-30T18:02:58.325388Z","end":"2026-06-30T18:02:58.584035Z","steps":["trace[1011938837] 'agreement among raft nodes before linearized reading' (duration: 258.486695ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:02:58.584157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.856818ms","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-30T18:02:58.584201Z","caller":"traceutil/trace.go:171","msg":"trace[275992071] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4733; }","duration":"261.918629ms","start":"2026-06-30T18:02:58.322272Z","end":"2026-06-30T18:02:58.584191Z","steps":["trace[275992071] 'agreement among raft nodes before linearized reading' (duration: 261.823007ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:02:58.584226Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.537634ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-d6908e3e-7cbe-4d10-b10b-76e83711d6ac\" ","response":"range_response_count:1 size:3645"} {"level":"warn","ts":"2026-06-30T18:02:58.584289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.033085ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3243"} {"level":"info","ts":"2026-06-30T18:02:58.584317Z","caller":"traceutil/trace.go:171","msg":"trace[2087717623] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-d6908e3e-7cbe-4d10-b10b-76e83711d6ac; range_end:; response_count:1; response_revision:4733; }","duration":"105.672768ms","start":"2026-06-30T18:02:58.478623Z","end":"2026-06-30T18:02:58.584295Z","steps":["trace[2087717623] 'agreement among raft nodes before linearized reading' (duration: 105.37481ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:02:58.584336Z","caller":"traceutil/trace.go:171","msg":"trace[54552939] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:4733; }","duration":"121.128287ms","start":"2026-06-30T18:02:58.463196Z","end":"2026-06-30T18:02:58.584324Z","steps":["trace[54552939] 'agreement among raft nodes before linearized reading' (duration: 120.997474ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:02:58.584588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.983095ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-06-30T18:02:58.584642Z","caller":"traceutil/trace.go:171","msg":"trace[2052581124] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4733; }","duration":"265.055297ms","start":"2026-06-30T18:02:58.319572Z","end":"2026-06-30T18:02:58.584628Z","steps":["trace[2052581124] 'agreement among raft nodes before linearized reading' (duration: 264.944194ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:02:58.584846Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.532108ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-06-30T18:02:58.584894Z","caller":"traceutil/trace.go:171","msg":"trace[1041120681] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4733; }","duration":"278.60983ms","start":"2026-06-30T18:02:58.30627Z","end":"2026-06-30T18:02:58.58488Z","steps":["trace[1041120681] 'agreement among raft nodes before linearized reading' (duration: 278.482597ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:02:58.584908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"465.902224ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T18:02:58.584945Z","caller":"traceutil/trace.go:171","msg":"trace[114548948] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:4733; }","duration":"465.978186ms","start":"2026-06-30T18:02:58.118956Z","end":"2026-06-30T18:02:58.584934Z","steps":["trace[114548948] 'agreement among raft nodes before linearized reading' (duration: 465.915795ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:02:58.584987Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T18:02:58.118934Z","time spent":"466.044298ms","remote":"127.0.0.1:50442","response type":"/etcdserverpb.KV/Range","request count":0,"request size":114,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-06-30T18:02:58.585305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"394.043798ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-30T18:02:58.585388Z","caller":"traceutil/trace.go:171","msg":"trace[358462768] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4733; }","duration":"394.15343ms","start":"2026-06-30T18:02:58.19122Z","end":"2026-06-30T18:02:58.585373Z","steps":["trace[358462768] 'agreement among raft nodes before linearized reading' (duration: 392.92404ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:02:58.585429Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T18:02:58.191207Z","time spent":"394.211912ms","remote":"127.0.0.1:46376","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-30T18:02:58.587573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.155687ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-d6908e3e-7cbe-4d10-b10b-76e83711d6ac\" ","response":"range_response_count:1 size:3645"} {"level":"info","ts":"2026-06-30T18:02:58.587692Z","caller":"traceutil/trace.go:171","msg":"trace[1656479727] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-d6908e3e-7cbe-4d10-b10b-76e83711d6ac; range_end:; response_count:1; response_revision:4733; }","duration":"234.29074ms","start":"2026-06-30T18:02:58.353381Z","end":"2026-06-30T18:02:58.587672Z","steps":["trace[1656479727] 'agreement among raft nodes before linearized reading' (duration: 231.354147ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:02:59.481305Z","caller":"traceutil/trace.go:171","msg":"trace[1409287694] transaction","detail":"{read_only:false; response_revision:4745; number_of_response:1; }","duration":"140.064974ms","start":"2026-06-30T18:02:59.341193Z","end":"2026-06-30T18:02:59.481258Z","steps":["trace[1409287694] 'process raft request' (duration: 139.734476ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:03:00.849321Z","caller":"traceutil/trace.go:171","msg":"trace[1486471565] transaction","detail":"{read_only:false; response_revision:4764; number_of_response:1; }","duration":"214.486333ms","start":"2026-06-30T18:03:00.634712Z","end":"2026-06-30T18:03:00.849199Z","steps":["trace[1486471565] 'process raft request' (duration: 205.528303ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:03:02.95252Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13322104105328917246,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-30T18:03:02.967843Z","caller":"traceutil/trace.go:171","msg":"trace[1969504992] transaction","detail":"{read_only:false; response_revision:4787; number_of_response:1; }","duration":"563.615237ms","start":"2026-06-30T18:03:02.404197Z","end":"2026-06-30T18:03:02.967812Z","steps":["trace[1969504992] 'process raft request' (duration: 563.448643ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:03:02.967992Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T18:03:02.404186Z","time spent":"563.731639ms","remote":"127.0.0.1:46316","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3938,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T18:03:03.123347Z","caller":"traceutil/trace.go:171","msg":"trace[1695125509] transaction","detail":"{read_only:false; response_revision:4790; number_of_response:1; }","duration":"291.505897ms","start":"2026-06-30T18:03:02.831817Z","end":"2026-06-30T18:03:03.123323Z","steps":["trace[1695125509] 'process raft request' (duration: 291.441296ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:03:03.123372Z","caller":"traceutil/trace.go:171","msg":"trace[1727307579] transaction","detail":"{read_only:false; response_revision:4789; number_of_response:1; }","duration":"524.743331ms","start":"2026-06-30T18:03:02.598593Z","end":"2026-06-30T18:03:03.123337Z","steps":["trace[1727307579] 'process raft request' (duration: 524.603647ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:03:03.123538Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T18:03:02.598568Z","time spent":"524.881534ms","remote":"127.0.0.1:46376","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T18:03:03.123546Z","caller":"traceutil/trace.go:171","msg":"trace[481817159] linearizableReadLoop","detail":"{readStateIndex:4973; appliedIndex:4968; }","duration":"672.089233ms","start":"2026-06-30T18:03:02.451446Z","end":"2026-06-30T18:03:03.123535Z","steps":["trace[481817159] 'read index received' (duration: 516.242022ms)","trace[481817159] 'applied index is now lower than readState.Index' (duration: 155.846091ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T18:03:03.123613Z","caller":"traceutil/trace.go:171","msg":"trace[1236922534] transaction","detail":"{read_only:false; response_revision:4791; number_of_response:1; }","duration":"269.595559ms","start":"2026-06-30T18:03:02.853985Z","end":"2026-06-30T18:03:03.123581Z","steps":["trace[1236922534] 'process raft request' (duration: 269.305421ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:03:03.123693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"672.228287ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.57\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-06-30T18:03:03.123727Z","caller":"traceutil/trace.go:171","msg":"trace[436822146] range","detail":"{range_begin:/registry/masterleases/199.204.45.57; range_end:; response_count:1; response_revision:4791; }","duration":"672.297299ms","start":"2026-06-30T18:03:02.45142Z","end":"2026-06-30T18:03:03.123717Z","steps":["trace[436822146] 'agreement among raft nodes before linearized reading' (duration: 672.146155ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:03:03.123756Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T18:03:02.451405Z","time spent":"672.34294ms","remote":"127.0.0.1:46186","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.204.45.57\" "} {"level":"warn","ts":"2026-06-30T18:03:03.123779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"644.228819ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-30T18:03:03.123827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"486.770007ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-06-30T18:03:03.123835Z","caller":"traceutil/trace.go:171","msg":"trace[324813335] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4791; }","duration":"644.28735ms","start":"2026-06-30T18:03:02.479531Z","end":"2026-06-30T18:03:03.123818Z","steps":["trace[324813335] 'agreement among raft nodes before linearized reading' (duration: 644.189158ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:03:03.123849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"432.083753ms","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-30T18:03:03.123869Z","caller":"traceutil/trace.go:171","msg":"trace[192444214] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4791; }","duration":"486.846629ms","start":"2026-06-30T18:03:02.637004Z","end":"2026-06-30T18:03:03.123851Z","steps":["trace[192444214] 'agreement among raft nodes before linearized reading' (duration: 486.734636ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:03:03.123883Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T18:03:02.479461Z","time spent":"644.415273ms","remote":"127.0.0.1:46150","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-30T18:03:03.12391Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T18:03:02.636978Z","time spent":"486.924341ms","remote":"127.0.0.1:46376","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":578,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"warn","ts":"2026-06-30T18:03:03.123909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"485.65322ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"warn","ts":"2026-06-30T18:03:03.123976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.951212ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-tnp6h\" ","response":"range_response_count:1 size:9938"} {"level":"info","ts":"2026-06-30T18:03:03.123971Z","caller":"traceutil/trace.go:171","msg":"trace[2059856992] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4791; }","duration":"485.742302ms","start":"2026-06-30T18:03:02.638215Z","end":"2026-06-30T18:03:03.123957Z","steps":["trace[2059856992] 'agreement among raft nodes before linearized reading' (duration: 485.558327ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:03:03.124021Z","caller":"traceutil/trace.go:171","msg":"trace[277342523] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-tnp6h; range_end:; response_count:1; response_revision:4791; }","duration":"151.026243ms","start":"2026-06-30T18:03:02.972985Z","end":"2026-06-30T18:03:03.124011Z","steps":["trace[277342523] 'agreement among raft nodes before linearized reading' (duration: 150.928941ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:03:03.124032Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T18:03:02.638209Z","time spent":"485.815403ms","remote":"127.0.0.1:46376","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":"warn","ts":"2026-06-30T18:03:03.124051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"431.189671ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-06-30T18:03:03.12408Z","caller":"traceutil/trace.go:171","msg":"trace[1390328729] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4791; }","duration":"431.248262ms","start":"2026-06-30T18:03:02.692823Z","end":"2026-06-30T18:03:03.124071Z","steps":["trace[1390328729] 'agreement among raft nodes before linearized reading' (duration: 431.154079ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:03:03.124106Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T18:03:02.692807Z","time spent":"431.294123ms","remote":"127.0.0.1:46376","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-30T18:03:03.123885Z","caller":"traceutil/trace.go:171","msg":"trace[1586155668] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4791; }","duration":"432.135744ms","start":"2026-06-30T18:03:02.691738Z","end":"2026-06-30T18:03:03.123874Z","steps":["trace[1586155668] 'agreement among raft nodes before linearized reading' (duration: 431.98265ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:03:03.124081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"506.377769ms","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-30T18:03:03.124145Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T18:03:02.69173Z","time spent":"432.40752ms","remote":"127.0.0.1:46376","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-30T18:03:03.124159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"521.127552ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-d6908e3e-7cbe-4d10-b10b-76e83711d6ac\" ","response":"range_response_count:1 size:3953"} {"level":"info","ts":"2026-06-30T18:03:03.124176Z","caller":"traceutil/trace.go:171","msg":"trace[275035959] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4791; }","duration":"506.556824ms","start":"2026-06-30T18:03:02.617595Z","end":"2026-06-30T18:03:03.124152Z","steps":["trace[275035959] 'agreement among raft nodes before linearized reading' (duration: 506.190885ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:03:03.124196Z","caller":"traceutil/trace.go:171","msg":"trace[944885163] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-d6908e3e-7cbe-4d10-b10b-76e83711d6ac; range_end:; response_count:1; response_revision:4791; }","duration":"521.188563ms","start":"2026-06-30T18:03:02.602995Z","end":"2026-06-30T18:03:03.124184Z","steps":["trace[944885163] 'agreement among raft nodes before linearized reading' (duration: 521.088371ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:03:03.124201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"431.358725ms","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":"warn","ts":"2026-06-30T18:03:03.124226Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T18:03:02.602985Z","time spent":"521.234554ms","remote":"127.0.0.1:46316","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3976,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-d6908e3e-7cbe-4d10-b10b-76e83711d6ac\" "} {"level":"warn","ts":"2026-06-30T18:03:03.124225Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T18:03:02.617585Z","time spent":"506.630075ms","remote":"127.0.0.1:46376","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-30T18:03:03.124236Z","caller":"traceutil/trace.go:171","msg":"trace[327934090] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4791; }","duration":"431.407465ms","start":"2026-06-30T18:03:02.692819Z","end":"2026-06-30T18:03:03.124226Z","steps":["trace[327934090] 'agreement among raft nodes before linearized reading' (duration: 431.310643ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:03:03.124271Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T18:03:02.69281Z","time spent":"431.454947ms","remote":"127.0.0.1:46376","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-06-30T18:03:03.124411Z","caller":"traceutil/trace.go:171","msg":"trace[999308088] transaction","detail":"{read_only:false; response_revision:4788; number_of_response:1; }","duration":"718.592227ms","start":"2026-06-30T18:03:02.405121Z","end":"2026-06-30T18:03:03.123713Z","steps":["trace[999308088] 'process raft request' (duration: 671.686464ms)","trace[999308088] 'compare' (duration: 46.251087ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T18:03:03.124555Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T18:03:02.405115Z","time spent":"719.352045ms","remote":"127.0.0.1:46220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T18:03:11.415276Z","caller":"traceutil/trace.go:171","msg":"trace[1956473121] transaction","detail":"{read_only:false; response_revision:4892; number_of_response:1; }","duration":"120.538333ms","start":"2026-06-30T18:03:11.294703Z","end":"2026-06-30T18:03:11.415229Z","steps":["trace[1956473121] 'process raft request' (duration: 94.37559ms)","trace[1956473121] 'compare' (duration: 25.896377ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T18:03:11.415393Z","caller":"traceutil/trace.go:171","msg":"trace[403790909] transaction","detail":"{read_only:false; response_revision:4896; number_of_response:1; }","duration":"119.875127ms","start":"2026-06-30T18:03:11.295492Z","end":"2026-06-30T18:03:11.415368Z","steps":["trace[403790909] 'process raft request' (duration: 119.816866ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:03:11.41538Z","caller":"traceutil/trace.go:171","msg":"trace[1838158723] transaction","detail":"{read_only:false; response_revision:4893; number_of_response:1; }","duration":"120.39602ms","start":"2026-06-30T18:03:11.294954Z","end":"2026-06-30T18:03:11.41535Z","steps":["trace[1838158723] 'process raft request' (duration: 120.174145ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:03:11.41554Z","caller":"traceutil/trace.go:171","msg":"trace[892014674] transaction","detail":"{read_only:false; response_revision:4895; number_of_response:1; }","duration":"120.120483ms","start":"2026-06-30T18:03:11.295402Z","end":"2026-06-30T18:03:11.415523Z","steps":["trace[892014674] 'process raft request' (duration: 119.819736ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:03:11.415555Z","caller":"traceutil/trace.go:171","msg":"trace[168219636] transaction","detail":"{read_only:false; response_revision:4894; number_of_response:1; }","duration":"120.39028ms","start":"2026-06-30T18:03:11.295108Z","end":"2026-06-30T18:03:11.415499Z","steps":["trace[168219636] 'process raft request' (duration: 120.064732ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:03:13.426763Z","caller":"traceutil/trace.go:171","msg":"trace[988719630] linearizableReadLoop","detail":"{readStateIndex:5100; appliedIndex:5098; }","duration":"132.673493ms","start":"2026-06-30T18:03:13.294067Z","end":"2026-06-30T18:03:13.42674Z","steps":["trace[988719630] 'read index received' (duration: 20.809742ms)","trace[988719630] 'applied index is now lower than readState.Index' (duration: 111.862791ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T18:03:13.426833Z","caller":"traceutil/trace.go:171","msg":"trace[127297954] transaction","detail":"{read_only:false; response_revision:4912; number_of_response:1; }","duration":"153.906644ms","start":"2026-06-30T18:03:13.272892Z","end":"2026-06-30T18:03:13.426799Z","steps":["trace[127297954] 'process raft request' (duration: 112.517556ms)","trace[127297954] 'compare' (duration: 41.160952ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T18:03:13.426982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.899918ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-06-30T18:03:13.427022Z","caller":"traceutil/trace.go:171","msg":"trace[642396692] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4912; }","duration":"132.98281ms","start":"2026-06-30T18:03:13.294029Z","end":"2026-06-30T18:03:13.427012Z","steps":["trace[642396692] 'agreement among raft nodes before linearized reading' (duration: 132.848547ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:03:14.105461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.866074ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-30T18:03:14.10568Z","caller":"traceutil/trace.go:171","msg":"trace[901338519] transaction","detail":"{read_only:false; response_revision:4914; number_of_response:1; }","duration":"673.289593ms","start":"2026-06-30T18:03:13.432364Z","end":"2026-06-30T18:03:14.105653Z","steps":["trace[901338519] 'process raft request' (duration: 673.203461ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:03:14.105781Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T18:03:13.432346Z","time spent":"673.390696ms","remote":"127.0.0.1:46376","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T18:03:14.10588Z","caller":"traceutil/trace.go:171","msg":"trace[1351986959] transaction","detail":"{read_only:false; response_revision:4913; number_of_response:1; }","duration":"673.452097ms","start":"2026-06-30T18:03:13.432364Z","end":"2026-06-30T18:03:14.105816Z","steps":["trace[1351986959] 'process raft request' (duration: 425.135052ms)","trace[1351986959] 'compare' (duration: 247.29483ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T18:03:14.106129Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T18:03:13.432346Z","time spent":"673.648373ms","remote":"127.0.0.1:46376","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T18:03:14.126678Z","caller":"traceutil/trace.go:171","msg":"trace[185970419] transaction","detail":"{read_only:false; response_revision:4915; number_of_response:1; }","duration":"694.164787ms","start":"2026-06-30T18:03:13.432493Z","end":"2026-06-30T18:03:14.126657Z","steps":["trace[185970419] 'process raft request' (duration: 693.858989ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:03:14.12678Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T18:03:13.432485Z","time spent":"694.245058ms","remote":"127.0.0.1:46376","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":539,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T18:03:14.126816Z","caller":"traceutil/trace.go:171","msg":"trace[1470701113] transaction","detail":"{read_only:false; response_revision:4916; number_of_response:1; }","duration":"694.248559ms","start":"2026-06-30T18:03:13.432547Z","end":"2026-06-30T18:03:14.126795Z","steps":["trace[1470701113] 'process raft request' (duration: 693.934591ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:03:14.12693Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T18:03:13.432541Z","time spent":"694.330331ms","remote":"127.0.0.1:46376","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-30T18:03:14.127093Z","caller":"traceutil/trace.go:171","msg":"trace[1643108131] transaction","detail":"{read_only:false; response_revision:4917; number_of_response:1; }","duration":"694.437504ms","start":"2026-06-30T18:03:13.432642Z","end":"2026-06-30T18:03:14.127079Z","steps":["trace[1643108131] 'process raft request' (duration: 694.120426ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:03:14.127148Z","caller":"traceutil/trace.go:171","msg":"trace[444239845] transaction","detail":"{read_only:false; response_revision:4920; number_of_response:1; }","duration":"528.390511ms","start":"2026-06-30T18:03:13.598748Z","end":"2026-06-30T18:03:14.127139Z","steps":["trace[444239845] 'process raft request' (duration: 528.34495ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:03:14.127164Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T18:03:13.432634Z","time spent":"694.496435ms","remote":"127.0.0.1:46376","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T18:03:14.127197Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T18:03:13.598721Z","time spent":"528.454483ms","remote":"127.0.0.1:46376","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-30T18:03:14.127269Z","caller":"traceutil/trace.go:171","msg":"trace[1453234074] transaction","detail":"{read_only:false; response_revision:4918; number_of_response:1; }","duration":"694.207237ms","start":"2026-06-30T18:03:13.433051Z","end":"2026-06-30T18:03:14.127259Z","steps":["trace[1453234074] 'process raft request' (duration: 693.980632ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:03:14.127325Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T18:03:13.433042Z","time spent":"694.256559ms","remote":"127.0.0.1:46376","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T18:03:14.127376Z","caller":"traceutil/trace.go:171","msg":"trace[103245227] transaction","detail":"{read_only:false; response_revision:4919; number_of_response:1; }","duration":"670.022844ms","start":"2026-06-30T18:03:13.457256Z","end":"2026-06-30T18:03:14.127279Z","steps":["trace[103245227] 'process raft request' (duration: 669.810489ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:03:14.127512Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T18:03:13.45724Z","time spent":"670.187388ms","remote":"127.0.0.1:46376","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T18:03:14.127687Z","caller":"traceutil/trace.go:171","msg":"trace[1111363140] transaction","detail":"{read_only:false; response_revision:4921; number_of_response:1; }","duration":"278.183639ms","start":"2026-06-30T18:03:13.849485Z","end":"2026-06-30T18:03:14.127668Z","steps":["trace[1111363140] 'process raft request' (duration: 277.628676ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:03:14.127696Z","caller":"traceutil/trace.go:171","msg":"trace[652305616] linearizableReadLoop","detail":"{readStateIndex:5107; appliedIndex:5100; }","duration":"644.419404ms","start":"2026-06-30T18:03:13.483235Z","end":"2026-06-30T18:03:14.127655Z","steps":["trace[652305616] 'read index received' (duration: 374.253712ms)","trace[652305616] 'applied index is now lower than readState.Index' (duration: 270.164132ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T18:03:14.128091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"644.825025ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:10391"} {"level":"info","ts":"2026-06-30T18:03:14.128138Z","caller":"traceutil/trace.go:171","msg":"trace[1335411868] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4921; }","duration":"644.925827ms","start":"2026-06-30T18:03:13.483199Z","end":"2026-06-30T18:03:14.128125Z","steps":["trace[1335411868] 'agreement among raft nodes before linearized reading' (duration: 644.67085ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:03:14.128183Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T18:03:13.48318Z","time spent":"644.987389ms","remote":"127.0.0.1:46316","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":10414,"request content":"key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" "} {"level":"warn","ts":"2026-06-30T18:03:14.138964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"654.835031ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T18:03:14.139023Z","caller":"traceutil/trace.go:171","msg":"trace[930888864] transaction","detail":"{read_only:false; response_revision:4922; number_of_response:1; }","duration":"113.418498ms","start":"2026-06-30T18:03:14.025593Z","end":"2026-06-30T18:03:14.139012Z","steps":["trace[930888864] 'process raft request' (duration: 113.195433ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:03:14.139023Z","caller":"traceutil/trace.go:171","msg":"trace[800513112] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4922; }","duration":"654.903172ms","start":"2026-06-30T18:03:13.484103Z","end":"2026-06-30T18:03:14.139007Z","steps":["trace[800513112] 'agreement among raft nodes before linearized reading' (duration: 654.767149ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:03:14.139066Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T18:03:13.484099Z","time spent":"654.958424ms","remote":"127.0.0.1:46150","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-30T18:03:14.13898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"366.04653ms","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:7"} {"level":"warn","ts":"2026-06-30T18:03:14.139234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"647.285565ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-06-30T18:03:14.139274Z","caller":"traceutil/trace.go:171","msg":"trace[1340119430] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:4922; }","duration":"366.369959ms","start":"2026-06-30T18:03:13.772894Z","end":"2026-06-30T18:03:14.139264Z","steps":["trace[1340119430] 'agreement among raft nodes before linearized reading' (duration: 366.03537ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:03:14.139289Z","caller":"traceutil/trace.go:171","msg":"trace[1542441404] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4922; }","duration":"647.367157ms","start":"2026-06-30T18:03:13.491903Z","end":"2026-06-30T18:03:14.13927Z","steps":["trace[1542441404] 'agreement among raft nodes before linearized reading' (duration: 647.193013ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:03:14.139309Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T18:03:13.772878Z","time spent":"366.42192ms","remote":"127.0.0.1:40520","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":30,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "} {"level":"warn","ts":"2026-06-30T18:03:14.139325Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T18:03:13.491887Z","time spent":"647.429699ms","remote":"127.0.0.1:46284","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":1,"response size":1888,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" "} {"level":"warn","ts":"2026-06-30T18:03:14.139726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"411.562039ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3243"} {"level":"info","ts":"2026-06-30T18:03:14.139808Z","caller":"traceutil/trace.go:171","msg":"trace[1879842272] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:4922; }","duration":"411.684762ms","start":"2026-06-30T18:03:13.7281Z","end":"2026-06-30T18:03:14.139785Z","steps":["trace[1879842272] 'agreement among raft nodes before linearized reading' (duration: 411.418706ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:03:14.139945Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T18:03:13.728084Z","time spent":"411.757174ms","remote":"127.0.0.1:43954","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":1,"response size":3266,"request content":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" "} {"level":"info","ts":"2026-06-30T18:03:14.251839Z","caller":"traceutil/trace.go:171","msg":"trace[1374282810] linearizableReadLoop","detail":"{readStateIndex:5111; appliedIndex:5110; }","duration":"102.222263ms","start":"2026-06-30T18:03:14.149574Z","end":"2026-06-30T18:03:14.251796Z","steps":["trace[1374282810] 'read index received' (duration: 81.777101ms)","trace[1374282810] 'applied index is now lower than readState.Index' (duration: 20.442432ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T18:03:14.252044Z","caller":"traceutil/trace.go:171","msg":"trace[1062924388] transaction","detail":"{read_only:false; response_revision:4923; number_of_response:1; }","duration":"106.260852ms","start":"2026-06-30T18:03:14.145741Z","end":"2026-06-30T18:03:14.252002Z","steps":["trace[1062924388] 'process raft request' (duration: 85.774619ms)","trace[1062924388] 'compare' (duration: 19.761186ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T18:03:14.252199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.586132ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/rabbitmq-keystone-nodes\" ","response":"range_response_count:1 size:1265"} {"level":"info","ts":"2026-06-30T18:03:14.252239Z","caller":"traceutil/trace.go:171","msg":"trace[213610928] range","detail":"{range_begin:/registry/services/specs/openstack/rabbitmq-keystone-nodes; range_end:; response_count:1; response_revision:4923; }","duration":"102.699745ms","start":"2026-06-30T18:03:14.149527Z","end":"2026-06-30T18:03:14.252227Z","steps":["trace[213610928] 'agreement among raft nodes before linearized reading' (duration: 102.424348ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:03:24.467799Z","caller":"traceutil/trace.go:171","msg":"trace[163722825] transaction","detail":"{read_only:false; response_revision:5011; number_of_response:1; }","duration":"114.945176ms","start":"2026-06-30T18:03:24.352828Z","end":"2026-06-30T18:03:24.467773Z","steps":["trace[163722825] 'process raft request' (duration: 114.770102ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:03:46.076588Z","caller":"traceutil/trace.go:171","msg":"trace[1304627412] transaction","detail":"{read_only:false; number_of_response:0; response_revision:5134; }","duration":"112.184849ms","start":"2026-06-30T18:03:45.964381Z","end":"2026-06-30T18:03:46.076566Z","steps":["trace[1304627412] 'process raft request' (duration: 112.100787ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:03:54.475627Z","caller":"traceutil/trace.go:171","msg":"trace[645779412] linearizableReadLoop","detail":"{readStateIndex:5475; appliedIndex:5474; }","duration":"114.372313ms","start":"2026-06-30T18:03:54.361227Z","end":"2026-06-30T18:03:54.475599Z","steps":["trace[645779412] 'read index received' (duration: 63.705217ms)","trace[645779412] 'applied index is now lower than readState.Index' (duration: 50.665756ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T18:03:54.475929Z","caller":"traceutil/trace.go:171","msg":"trace[908154166] transaction","detail":"{read_only:false; response_revision:5278; number_of_response:1; }","duration":"116.826713ms","start":"2026-06-30T18:03:54.359088Z","end":"2026-06-30T18:03:54.475915Z","steps":["trace[908154166] 'process raft request' (duration: 65.938331ms)","trace[908154166] 'compare' (duration: 50.391099ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T18:03:54.476269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.019339ms","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-30T18:03:54.476345Z","caller":"traceutil/trace.go:171","msg":"trace[690251450] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5278; }","duration":"115.135731ms","start":"2026-06-30T18:03:54.361192Z","end":"2026-06-30T18:03:54.476328Z","steps":["trace[690251450] 'agreement among raft nodes before linearized reading' (duration: 114.929406ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:03:56.40828Z","caller":"traceutil/trace.go:171","msg":"trace[1117418775] transaction","detail":"{read_only:false; response_revision:5288; number_of_response:1; }","duration":"106.278492ms","start":"2026-06-30T18:03:56.301976Z","end":"2026-06-30T18:03:56.408255Z","steps":["trace[1117418775] 'process raft request' (duration: 105.870452ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:03:56.660351Z","caller":"traceutil/trace.go:171","msg":"trace[1166751154] transaction","detail":"{read_only:false; response_revision:5293; number_of_response:1; }","duration":"104.49731ms","start":"2026-06-30T18:03:56.555831Z","end":"2026-06-30T18:03:56.660329Z","steps":["trace[1166751154] 'process raft request' (duration: 91.93367ms)","trace[1166751154] 'compare' (duration: 12.455607ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T18:03:56.66065Z","caller":"traceutil/trace.go:171","msg":"trace[582457251] transaction","detail":"{read_only:false; response_revision:5294; number_of_response:1; }","duration":"103.216178ms","start":"2026-06-30T18:03:56.557416Z","end":"2026-06-30T18:03:56.660633Z","steps":["trace[582457251] 'process raft request' (duration: 102.87694ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:03:57.890279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.862742ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-06-30T18:03:58.809755Z","caller":"traceutil/trace.go:171","msg":"trace[10105143] transaction","detail":"{read_only:false; response_revision:5305; number_of_response:1; }","duration":"138.536056ms","start":"2026-06-30T18:03:58.671184Z","end":"2026-06-30T18:03:58.80972Z","steps":["trace[10105143] 'process raft request' (duration: 53.914015ms)","trace[10105143] 'compare' (duration: 84.491558ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T18:04:18.594357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.756864ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:530"} {"level":"warn","ts":"2026-06-30T18:04:18.594378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.511555ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T18:04:18.594465Z","caller":"traceutil/trace.go:171","msg":"trace[1400906856] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:5449; }","duration":"171.904337ms","start":"2026-06-30T18:04:18.422536Z","end":"2026-06-30T18:04:18.59444Z","steps":["trace[1400906856] 'range keys from in-memory index tree' (duration: 171.532108ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:04:18.594471Z","caller":"traceutil/trace.go:171","msg":"trace[225481051] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5449; }","duration":"114.657049ms","start":"2026-06-30T18:04:18.479794Z","end":"2026-06-30T18:04:18.594451Z","steps":["trace[225481051] 'range keys from in-memory index tree' (duration: 114.389463ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:04:19.57397Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2827} {"level":"info","ts":"2026-06-30T18:04:19.771756Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2827,"took":"196.214335ms","hash":2301809402,"current-db-size-bytes":53932032,"current-db-size":"54 MB","current-db-size-in-use-bytes":28876800,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-06-30T18:04:19.771856Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2301809402,"revision":2827,"compact-revision":-1} {"level":"warn","ts":"2026-06-30T18:06:24.870253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.654242ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-30T18:06:24.870638Z","caller":"traceutil/trace.go:171","msg":"trace[487749536] transaction","detail":"{read_only:false; response_revision:6229; number_of_response:1; }","duration":"262.742772ms","start":"2026-06-30T18:06:24.607876Z","end":"2026-06-30T18:06:24.870619Z","steps":["trace[487749536] 'process raft request' (duration: 262.513916ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:06:24.870637Z","caller":"traceutil/trace.go:171","msg":"trace[619543053] transaction","detail":"{read_only:false; response_revision:6228; number_of_response:1; }","duration":"277.017593ms","start":"2026-06-30T18:06:24.593587Z","end":"2026-06-30T18:06:24.870605Z","steps":["trace[619543053] 'process raft request' (duration: 156.914569ms)","trace[619543053] 'compare' (duration: 119.116079ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T18:07:18.774785Z","caller":"traceutil/trace.go:171","msg":"trace[998073342] linearizableReadLoop","detail":"{readStateIndex:6953; appliedIndex:6952; }","duration":"357.298319ms","start":"2026-06-30T18:07:18.41746Z","end":"2026-06-30T18:07:18.774759Z","steps":["trace[998073342] 'read index received' (duration: 356.923239ms)","trace[998073342] 'applied index is now lower than readState.Index' (duration: 374.2µs)"],"step_count":2} {"level":"info","ts":"2026-06-30T18:07:18.775027Z","caller":"traceutil/trace.go:171","msg":"trace[1160731358] transaction","detail":"{read_only:false; response_revision:6705; number_of_response:1; }","duration":"567.813776ms","start":"2026-06-30T18:07:18.207205Z","end":"2026-06-30T18:07:18.775019Z","steps":["trace[1160731358] 'process raft request' (duration: 567.246252ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:07:18.775104Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T18:07:18.207185Z","time spent":"567.859648ms","remote":"127.0.0.1:46376","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T18:07:18.775232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"357.783151ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/exchanges/\" range_end:\"/registry/rabbitmq.com/exchanges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T18:07:18.775254Z","caller":"traceutil/trace.go:171","msg":"trace[111942514] range","detail":"{range_begin:/registry/rabbitmq.com/exchanges/; range_end:/registry/rabbitmq.com/exchanges0; response_count:0; response_revision:6705; }","duration":"357.863403ms","start":"2026-06-30T18:07:18.417382Z","end":"2026-06-30T18:07:18.775245Z","steps":["trace[111942514] 'agreement among raft nodes before linearized reading' (duration: 357.822372ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:07:18.775271Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T18:07:18.417343Z","time spent":"357.922174ms","remote":"127.0.0.1:43930","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":28,"request content":"key:\"/registry/rabbitmq.com/exchanges/\" range_end:\"/registry/rabbitmq.com/exchanges0\" count_only:true "} {"level":"warn","ts":"2026-06-30T18:07:18.775367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.331658ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T18:07:18.77538Z","caller":"traceutil/trace.go:171","msg":"trace[1290024387] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:6705; }","duration":"298.37633ms","start":"2026-06-30T18:07:18.477Z","end":"2026-06-30T18:07:18.775376Z","steps":["trace[1290024387] 'agreement among raft nodes before linearized reading' (duration: 298.352799ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T18:07:30.847599Z","caller":"traceutil/trace.go:171","msg":"trace[1971883408] linearizableReadLoop","detail":"{readStateIndex:7023; appliedIndex:7022; }","duration":"452.322937ms","start":"2026-06-30T18:07:30.395256Z","end":"2026-06-30T18:07:30.847579Z","steps":["trace[1971883408] 'read index received' (duration: 395.464647ms)","trace[1971883408] 'applied index is now lower than readState.Index' (duration: 56.85764ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T18:07:30.847682Z","caller":"traceutil/trace.go:171","msg":"trace[1680519686] transaction","detail":"{read_only:false; response_revision:6773; number_of_response:1; }","duration":"456.381396ms","start":"2026-06-30T18:07:30.391293Z","end":"2026-06-30T18:07:30.847675Z","steps":["trace[1680519686] 'process raft request' (duration: 399.448014ms)","trace[1680519686] 'compare' (duration: 56.743718ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T18:07:30.847761Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T18:07:30.39126Z","time spent":"456.436948ms","remote":"127.0.0.1:46300","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":12281,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T18:07:30.847971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"366.599418ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T18:07:30.848043Z","caller":"traceutil/trace.go:171","msg":"trace[1580712568] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:6773; }","duration":"366.718091ms","start":"2026-06-30T18:07:30.481307Z","end":"2026-06-30T18:07:30.848025Z","steps":["trace[1580712568] 'agreement among raft nodes before linearized reading' (duration: 366.593658ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:07:30.848085Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T18:07:30.48129Z","time spent":"366.786153ms","remote":"127.0.0.1:46150","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-30T18:07:30.848136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.404729ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/permissions/\" range_end:\"/registry/rabbitmq.com/permissions0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T18:07:30.848162Z","caller":"traceutil/trace.go:171","msg":"trace[394561743] range","detail":"{range_begin:/registry/rabbitmq.com/permissions/; range_end:/registry/rabbitmq.com/permissions0; response_count:0; response_revision:6773; }","duration":"328.45427ms","start":"2026-06-30T18:07:30.5197Z","end":"2026-06-30T18:07:30.848154Z","steps":["trace[394561743] 'agreement among raft nodes before linearized reading' (duration: 328.413509ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:07:30.848177Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T18:07:30.519689Z","time spent":"328.484581ms","remote":"127.0.0.1:43862","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":28,"request content":"key:\"/registry/rabbitmq.com/permissions/\" range_end:\"/registry/rabbitmq.com/permissions0\" count_only:true "} {"level":"warn","ts":"2026-06-30T18:07:30.848365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"453.110316ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/perconaxtradbclusters.pxc.percona.com\" ","response":"range_response_count:1 size:187546"} {"level":"info","ts":"2026-06-30T18:07:30.851981Z","caller":"traceutil/trace.go:171","msg":"trace[1973009343] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/perconaxtradbclusters.pxc.percona.com; range_end:; response_count:1; response_revision:6773; }","duration":"453.214479ms","start":"2026-06-30T18:07:30.395165Z","end":"2026-06-30T18:07:30.848379Z","steps":["trace[1973009343] 'agreement among raft nodes before linearized reading' (duration: 452.668975ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:07:30.852216Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T18:07:30.395154Z","time spent":"457.011592ms","remote":"127.0.0.1:46194","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":1,"response size":187569,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/perconaxtradbclusters.pxc.percona.com\" "} {"level":"warn","ts":"2026-06-30T18:07:30.853288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.024809ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/vhosts/\" range_end:\"/registry/rabbitmq.com/vhosts0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T18:07:30.85339Z","caller":"traceutil/trace.go:171","msg":"trace[2131763833] range","detail":"{range_begin:/registry/rabbitmq.com/vhosts/; range_end:/registry/rabbitmq.com/vhosts0; response_count:0; response_revision:6773; }","duration":"354.150742ms","start":"2026-06-30T18:07:30.499206Z","end":"2026-06-30T18:07:30.853357Z","steps":["trace[2131763833] 'agreement among raft nodes before linearized reading' (duration: 349.084157ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:07:30.853423Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T18:07:30.499195Z","time spent":"354.216914ms","remote":"127.0.0.1:43856","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":0,"response size":28,"request content":"key:\"/registry/rabbitmq.com/vhosts/\" range_end:\"/registry/rabbitmq.com/vhosts0\" count_only:true "} {"level":"info","ts":"2026-06-30T18:08:07.863575Z","caller":"traceutil/trace.go:171","msg":"trace[741547257] transaction","detail":"{read_only:false; response_revision:6982; number_of_response:1; }","duration":"567.912258ms","start":"2026-06-30T18:08:07.295618Z","end":"2026-06-30T18:08:07.863531Z","steps":["trace[741547257] 'process raft request' (duration: 567.745844ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:08:07.864006Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T18:08:07.295584Z","time spent":"568.075641ms","remote":"127.0.0.1:46376","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T18:08:07.864516Z","caller":"traceutil/trace.go:171","msg":"trace[1686447039] transaction","detail":"{read_only:false; response_revision:6983; number_of_response:1; }","duration":"567.804235ms","start":"2026-06-30T18:08:07.296688Z","end":"2026-06-30T18:08:07.864492Z","steps":["trace[1686447039] 'process raft request' (duration: 567.649921ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:08:07.86465Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T18:08:07.296672Z","time spent":"567.922118ms","remote":"127.0.0.1:46376","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T18:08:07.867489Z","caller":"traceutil/trace.go:171","msg":"trace[1951051540] linearizableReadLoop","detail":"{readStateIndex:7240; appliedIndex:7238; }","duration":"387.822709ms","start":"2026-06-30T18:08:07.479647Z","end":"2026-06-30T18:08:07.86747Z","steps":["trace[1951051540] 'read index received' (duration: 383.726748ms)","trace[1951051540] 'applied index is now lower than readState.Index' (duration: 4.094981ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T18:08:07.867619Z","caller":"traceutil/trace.go:171","msg":"trace[140380808] transaction","detail":"{read_only:false; response_revision:6984; number_of_response:1; }","duration":"144.111505ms","start":"2026-06-30T18:08:07.723463Z","end":"2026-06-30T18:08:07.867575Z","steps":["trace[140380808] 'process raft request' (duration: 143.91834ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:08:07.867586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"387.926431ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T18:08:07.867843Z","caller":"traceutil/trace.go:171","msg":"trace[692825716] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:6984; }","duration":"388.227819ms","start":"2026-06-30T18:08:07.479598Z","end":"2026-06-30T18:08:07.867826Z","steps":["trace[692825716] 'agreement among raft nodes before linearized reading' (duration: 387.944502ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T18:08:07.867949Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T18:08:07.479575Z","time spent":"388.360831ms","remote":"127.0.0.1:46152","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-30T18:09:19.581349Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5462} {"level":"info","ts":"2026-06-30T18:09:19.660599Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5462,"took":"77.489105ms","hash":3569371781,"current-db-size-bytes":53932032,"current-db-size":"54 MB","current-db-size-in-use-bytes":18419712,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-06-30T18:09:19.660791Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3569371781,"revision":5462,"compact-revision":2827}