{"level":"warn","ts":"2026-07-08T23:37:30.450096Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-08T23:37:30.450197Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.177: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.177:2380","--initial-cluster=instance=https://199.204.45.177:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.177:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.177: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-07-08T23:37:30.45027Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-08T23:37:30.450282Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.177:2380"]} {"level":"info","ts":"2026-07-08T23:37:30.450311Z","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-07-08T23:37:30.450938Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.177:2379"]} {"level":"info","ts":"2026-07-08T23:37:30.45102Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.177:2380"],"listen-peer-urls":["https://199.204.45.177:2380"],"advertise-client-urls":["https://199.204.45.177:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.177:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.177: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-07-08T23:37:30.455243Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.959556ms"} {"level":"info","ts":"2026-07-08T23:37:30.461767Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"7c53a18098324dc9","cluster-id":"4717e8aa221973c8"} {"level":"info","ts":"2026-07-08T23:37:30.461851Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7c53a18098324dc9 switched to configuration voters=()"} {"level":"info","ts":"2026-07-08T23:37:30.461877Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7c53a18098324dc9 became follower at term 0"} {"level":"info","ts":"2026-07-08T23:37:30.461888Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 7c53a18098324dc9 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-08T23:37:30.461897Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7c53a18098324dc9 became follower at term 1"} {"level":"info","ts":"2026-07-08T23:37:30.461932Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7c53a18098324dc9 switched to configuration voters=(8958681657451367881)"} {"level":"warn","ts":"2026-07-08T23:37:30.472024Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-08T23:37:30.474313Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-08T23:37:30.475532Z","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-07-08T23:37:30.477658Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"7c53a18098324dc9","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-08T23:37:30.478512Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"7c53a18098324dc9","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-08T23:37:30.478674Z","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-07-08T23:37:30.478906Z","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-07-08T23:37:30.479103Z","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-07-08T23:37:30.482206Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7c53a18098324dc9 switched to configuration voters=(8958681657451367881)"} {"level":"info","ts":"2026-07-08T23:37:30.482965Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"4717e8aa221973c8","local-member-id":"7c53a18098324dc9","added-peer-id":"7c53a18098324dc9","added-peer-peer-urls":["https://199.204.45.177:2380"]} {"level":"info","ts":"2026-07-08T23:37:30.485723Z","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-07-08T23:37:30.485821Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.177:2380"} {"level":"info","ts":"2026-07-08T23:37:30.485893Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.177:2380"} {"level":"info","ts":"2026-07-08T23:37:30.486052Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"7c53a18098324dc9","initial-advertise-peer-urls":["https://199.204.45.177:2380"],"listen-peer-urls":["https://199.204.45.177:2380"],"advertise-client-urls":["https://199.204.45.177:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.177:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-08T23:37:30.486114Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-08T23:37:30.563195Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7c53a18098324dc9 is starting a new election at term 1"} {"level":"info","ts":"2026-07-08T23:37:30.56327Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7c53a18098324dc9 became pre-candidate at term 1"} {"level":"info","ts":"2026-07-08T23:37:30.563303Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7c53a18098324dc9 received MsgPreVoteResp from 7c53a18098324dc9 at term 1"} {"level":"info","ts":"2026-07-08T23:37:30.563324Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7c53a18098324dc9 became candidate at term 2"} {"level":"info","ts":"2026-07-08T23:37:30.563341Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7c53a18098324dc9 received MsgVoteResp from 7c53a18098324dc9 at term 2"} {"level":"info","ts":"2026-07-08T23:37:30.563364Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7c53a18098324dc9 became leader at term 2"} {"level":"info","ts":"2026-07-08T23:37:30.563383Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 7c53a18098324dc9 elected leader 7c53a18098324dc9 at term 2"} {"level":"info","ts":"2026-07-08T23:37:30.564837Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-08T23:37:30.56573Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"7c53a18098324dc9","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.177:2379]}","request-path":"/0/members/7c53a18098324dc9/attributes","cluster-id":"4717e8aa221973c8","publish-timeout":"7s"} {"level":"info","ts":"2026-07-08T23:37:30.565803Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-08T23:37:30.565861Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-08T23:37:30.566094Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"4717e8aa221973c8","local-member-id":"7c53a18098324dc9","cluster-version":"3.5"} {"level":"info","ts":"2026-07-08T23:37:30.566241Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-08T23:37:30.566234Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-08T23:37:30.566286Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-08T23:37:30.566298Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-08T23:37:30.567632Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-08T23:37:30.572242Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.177:2379"} {"level":"info","ts":"2026-07-08T23:37:56.960828Z","caller":"traceutil/trace.go:171","msg":"trace[1250387665] transaction","detail":"{read_only:false; response_revision:427; number_of_response:1; }","duration":"261.965402ms","start":"2026-07-08T23:37:56.698824Z","end":"2026-07-08T23:37:56.960789Z","steps":["trace[1250387665] 'process raft request' (duration: 254.884624ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T23:37:56.963397Z","caller":"traceutil/trace.go:171","msg":"trace[1053645790] transaction","detail":"{read_only:false; response_revision:428; number_of_response:1; }","duration":"243.93548ms","start":"2026-07-08T23:37:56.719428Z","end":"2026-07-08T23:37:56.963364Z","steps":["trace[1053645790] 'process raft request' (duration: 243.773786ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T23:37:56.963866Z","caller":"traceutil/trace.go:171","msg":"trace[1324704609] linearizableReadLoop","detail":"{readStateIndex:445; appliedIndex:443; }","duration":"238.641646ms","start":"2026-07-08T23:37:56.725201Z","end":"2026-07-08T23:37:56.963843Z","steps":["trace[1324704609] 'read index received' (duration: 228.486267ms)","trace[1324704609] 'applied index is now lower than readState.Index' (duration: 10.153649ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T23:37:56.964002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.767188ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:4195"} {"level":"info","ts":"2026-07-08T23:37:56.964075Z","caller":"traceutil/trace.go:171","msg":"trace[1214667469] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:428; }","duration":"238.897931ms","start":"2026-07-08T23:37:56.72516Z","end":"2026-07-08T23:37:56.964058Z","steps":["trace[1214667469] 'agreement among raft nodes before linearized reading' (duration: 238.750358ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T23:38:16.443998Z","caller":"traceutil/trace.go:171","msg":"trace[1166858537] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"300.691889ms","start":"2026-07-08T23:38:16.143252Z","end":"2026-07-08T23:38:16.443944Z","steps":["trace[1166858537] 'process raft request' (duration: 299.960305ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T23:38:16.444806Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T23:38:16.143226Z","time spent":"300.869193ms","remote":"127.0.0.1:44054","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036261,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T23:38:16.452738Z","caller":"traceutil/trace.go:171","msg":"trace[1480958928] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"306.242275ms","start":"2026-07-08T23:38:16.146478Z","end":"2026-07-08T23:38:16.45272Z","steps":["trace[1480958928] 'process raft request' (duration: 306.167304ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T23:38:16.4528Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T23:38:16.146459Z","time spent":"306.310306ms","remote":"127.0.0.1:44232","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T23:38:16.912906Z","caller":"traceutil/trace.go:171","msg":"trace[1501419383] linearizableReadLoop","detail":"{readStateIndex:620; appliedIndex:619; }","duration":"246.695088ms","start":"2026-07-08T23:38:16.666174Z","end":"2026-07-08T23:38:16.912869Z","steps":["trace[1501419383] 'read index received' (duration: 213.520445ms)","trace[1501419383] 'applied index is now lower than readState.Index' (duration: 33.173163ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T23:38:16.912955Z","caller":"traceutil/trace.go:171","msg":"trace[1464180260] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"409.20041ms","start":"2026-07-08T23:38:16.503707Z","end":"2026-07-08T23:38:16.912908Z","steps":["trace[1464180260] 'process raft request' (duration: 375.913724ms)","trace[1464180260] 'compare' (duration: 33.052141ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T23:38:16.913147Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T23:38:16.503684Z","time spent":"409.361582ms","remote":"127.0.0.1:44326","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-08T23:38:16.913255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.066076ms","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-07-08T23:38:16.913348Z","caller":"traceutil/trace.go:171","msg":"trace[752995061] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:598; }","duration":"247.211268ms","start":"2026-07-08T23:38:16.666113Z","end":"2026-07-08T23:38:16.913324Z","steps":["trace[752995061] 'agreement among raft nodes before linearized reading' (duration: 246.900852ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T23:38:16.913525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.882122ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-07-08T23:38:16.913558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.120087ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-kwsn8\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-07-08T23:38:16.913702Z","caller":"traceutil/trace.go:171","msg":"trace[1901602078] range","detail":"{range_begin:/registry/pods/kube-system/cilium-kwsn8; range_end:; response_count:1; response_revision:598; }","duration":"171.325421ms","start":"2026-07-08T23:38:16.742346Z","end":"2026-07-08T23:38:16.913671Z","steps":["trace[1901602078] 'agreement among raft nodes before linearized reading' (duration: 171.072115ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T23:38:16.913591Z","caller":"traceutil/trace.go:171","msg":"trace[68058692] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:598; }","duration":"246.975624ms","start":"2026-07-08T23:38:16.666598Z","end":"2026-07-08T23:38:16.913573Z","steps":["trace[68058692] 'agreement among raft nodes before linearized reading' (duration: 246.497144ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T23:39:50.931528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.782423ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-07-08T23:39:50.931657Z","caller":"traceutil/trace.go:171","msg":"trace[1042040680] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1844; }","duration":"280.981397ms","start":"2026-07-08T23:39:50.650651Z","end":"2026-07-08T23:39:50.931633Z","steps":["trace[1042040680] 'range keys from in-memory index tree' (duration: 280.475537ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T23:39:50.954349Z","caller":"traceutil/trace.go:171","msg":"trace[1859956380] linearizableReadLoop","detail":"{readStateIndex:1915; appliedIndex:1914; }","duration":"104.012533ms","start":"2026-07-08T23:39:50.850299Z","end":"2026-07-08T23:39:50.954311Z","steps":["trace[1859956380] 'read index received' (duration: 103.805789ms)","trace[1859956380] 'applied index is now lower than readState.Index' (duration: 205.604µs)"],"step_count":2} {"level":"info","ts":"2026-07-08T23:39:50.954406Z","caller":"traceutil/trace.go:171","msg":"trace[2068664042] transaction","detail":"{read_only:false; response_revision:1845; number_of_response:1; }","duration":"225.437219ms","start":"2026-07-08T23:39:50.728932Z","end":"2026-07-08T23:39:50.954369Z","steps":["trace[2068664042] 'process raft request' (duration: 225.195254ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T23:39:50.954693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.370691ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-e736f985-e4dc-4366-829d-69519f99d764\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-07-08T23:39:50.95479Z","caller":"traceutil/trace.go:171","msg":"trace[251515730] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-e736f985-e4dc-4366-829d-69519f99d764; range_end:; response_count:1; response_revision:1845; }","duration":"104.546354ms","start":"2026-07-08T23:39:50.850222Z","end":"2026-07-08T23:39:50.954768Z","steps":["trace[251515730] 'agreement among raft nodes before linearized reading' (duration: 104.254389ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T23:39:51.388675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.609076ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-e736f985-e4dc-4366-829d-69519f99d764\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-07-08T23:39:51.388776Z","caller":"traceutil/trace.go:171","msg":"trace[276224226] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-e736f985-e4dc-4366-829d-69519f99d764; range_end:; response_count:1; response_revision:1847; }","duration":"104.777099ms","start":"2026-07-08T23:39:51.283974Z","end":"2026-07-08T23:39:51.388751Z","steps":["trace[276224226] 'range keys from in-memory index tree' (duration: 104.401691ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T23:40:06.807112Z","caller":"traceutil/trace.go:171","msg":"trace[911233932] transaction","detail":"{read_only:false; response_revision:1975; number_of_response:1; }","duration":"150.268996ms","start":"2026-07-08T23:40:06.656819Z","end":"2026-07-08T23:40:06.807088Z","steps":["trace[911233932] 'process raft request' (duration: 150.099853ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T23:40:39.972906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.056159ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-08T23:40:39.973113Z","caller":"traceutil/trace.go:171","msg":"trace[6183358] linearizableReadLoop","detail":"{readStateIndex:2246; appliedIndex:2245; }","duration":"153.048255ms","start":"2026-07-08T23:40:39.820045Z","end":"2026-07-08T23:40:39.973093Z","steps":["trace[6183358] 'read index received' (duration: 11.498806ms)","trace[6183358] 'applied index is now lower than readState.Index' (duration: 141.547509ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T23:40:39.973211Z","caller":"traceutil/trace.go:171","msg":"trace[877144228] transaction","detail":"{read_only:false; response_revision:2164; number_of_response:1; }","duration":"204.877277ms","start":"2026-07-08T23:40:39.768322Z","end":"2026-07-08T23:40:39.973199Z","steps":["trace[877144228] 'process raft request' (duration: 63.292208ms)","trace[877144228] 'compare' (duration: 140.910016ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T23:40:39.973794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.743639ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12382"} {"level":"info","ts":"2026-07-08T23:40:39.973869Z","caller":"traceutil/trace.go:171","msg":"trace[1939652764] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2164; }","duration":"153.856542ms","start":"2026-07-08T23:40:39.819994Z","end":"2026-07-08T23:40:39.97385Z","steps":["trace[1939652764] 'agreement among raft nodes before linearized reading' (duration: 153.661518ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T23:40:46.425571Z","caller":"traceutil/trace.go:171","msg":"trace[1224979132] transaction","detail":"{read_only:false; response_revision:2197; number_of_response:1; }","duration":"154.895513ms","start":"2026-07-08T23:40:46.270651Z","end":"2026-07-08T23:40:46.425546Z","steps":["trace[1224979132] 'process raft request' (duration: 154.7568ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T23:40:46.730529Z","caller":"traceutil/trace.go:171","msg":"trace[21896460] transaction","detail":"{read_only:false; response_revision:2198; number_of_response:1; }","duration":"455.270221ms","start":"2026-07-08T23:40:46.275231Z","end":"2026-07-08T23:40:46.730501Z","steps":["trace[21896460] 'process raft request' (duration: 455.105067ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T23:40:46.730718Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T23:40:46.275202Z","time spent":"455.414844ms","remote":"127.0.0.1:44232","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T23:40:46.904008Z","caller":"traceutil/trace.go:171","msg":"trace[1089619406] transaction","detail":"{read_only:false; response_revision:2199; number_of_response:1; }","duration":"473.603522ms","start":"2026-07-08T23:40:46.430374Z","end":"2026-07-08T23:40:46.903977Z","steps":["trace[1089619406] 'process raft request' (duration: 387.048488ms)","trace[1089619406] 'compare' (duration: 86.361671ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T23:40:46.904215Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T23:40:46.430346Z","time spent":"473.744164ms","remote":"127.0.0.1:44232","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-08T23:40:46.904232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.465129ms","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-07-08T23:40:46.904303Z","caller":"traceutil/trace.go:171","msg":"trace[1625557973] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2199; }","duration":"338.588051ms","start":"2026-07-08T23:40:46.565703Z","end":"2026-07-08T23:40:46.904291Z","steps":["trace[1625557973] 'agreement among raft nodes before linearized reading' (duration: 338.361286ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T23:40:46.903986Z","caller":"traceutil/trace.go:171","msg":"trace[98800747] linearizableReadLoop","detail":"{readStateIndex:2282; appliedIndex:2281; }","duration":"338.177203ms","start":"2026-07-08T23:40:46.565767Z","end":"2026-07-08T23:40:46.903944Z","steps":["trace[98800747] 'read index received' (duration: 164.818168ms)","trace[98800747] 'applied index is now lower than readState.Index' (duration: 173.357535ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T23:40:46.904344Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T23:40:46.565649Z","time spent":"338.686953ms","remote":"127.0.0.1:44232","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-07-08T23:40:46.904509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.122141ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-08T23:40:46.904585Z","caller":"traceutil/trace.go:171","msg":"trace[1849742637] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:2199; }","duration":"279.239223ms","start":"2026-07-08T23:40:46.625326Z","end":"2026-07-08T23:40:46.904565Z","steps":["trace[1849742637] 'agreement among raft nodes before linearized reading' (duration: 279.10451ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T23:41:21.256505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.511396ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-08T23:41:21.256707Z","caller":"traceutil/trace.go:171","msg":"trace[524058454] transaction","detail":"{read_only:false; response_revision:2559; number_of_response:1; }","duration":"196.770154ms","start":"2026-07-08T23:41:21.059914Z","end":"2026-07-08T23:41:21.256684Z","steps":["trace[524058454] 'process raft request' (duration: 27.983742ms)","trace[524058454] 'compare' (duration: 168.384544ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T23:41:21.256783Z","caller":"traceutil/trace.go:171","msg":"trace[1888038940] linearizableReadLoop","detail":"{readStateIndex:2656; appliedIndex:2655; }","duration":"180.912115ms","start":"2026-07-08T23:41:21.075822Z","end":"2026-07-08T23:41:21.256734Z","steps":["trace[1888038940] 'read index received' (duration: 12.047172ms)","trace[1888038940] 'applied index is now lower than readState.Index' (duration: 168.858743ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T23:41:21.256901Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.061087ms","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-07-08T23:41:21.256961Z","caller":"traceutil/trace.go:171","msg":"trace[1925495440] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:2560; }","duration":"181.16165ms","start":"2026-07-08T23:41:21.075786Z","end":"2026-07-08T23:41:21.256947Z","steps":["trace[1925495440] 'agreement among raft nodes before linearized reading' (duration: 181.052898ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T23:41:55.696466Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.28462ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-08T23:41:55.696671Z","caller":"traceutil/trace.go:171","msg":"trace[677624743] transaction","detail":"{read_only:false; response_revision:2770; number_of_response:1; }","duration":"190.04998ms","start":"2026-07-08T23:41:55.506597Z","end":"2026-07-08T23:41:55.696647Z","steps":["trace[677624743] 'process raft request' (duration: 189.992649ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T23:41:55.696678Z","caller":"traceutil/trace.go:171","msg":"trace[573918569] transaction","detail":"{read_only:false; response_revision:2769; number_of_response:1; }","duration":"277.733781ms","start":"2026-07-08T23:41:55.418881Z","end":"2026-07-08T23:41:55.696615Z","steps":["trace[573918569] 'process raft request' (duration: 126.192506ms)","trace[573918569] 'compare' (duration: 151.158618ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T23:41:55.696836Z","caller":"traceutil/trace.go:171","msg":"trace[291520712] linearizableReadLoop","detail":"{readStateIndex:2874; appliedIndex:2873; }","duration":"245.584695ms","start":"2026-07-08T23:41:55.45122Z","end":"2026-07-08T23:41:55.696804Z","steps":["trace[291520712] 'read index received' (duration: 93.866426ms)","trace[291520712] 'applied index is now lower than readState.Index' (duration: 151.714979ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T23:41:55.697114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.141736ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T23:41:55.697166Z","caller":"traceutil/trace.go:171","msg":"trace[1618881050] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:2770; }","duration":"244.220758ms","start":"2026-07-08T23:41:55.452931Z","end":"2026-07-08T23:41:55.697152Z","steps":["trace[1618881050] 'agreement among raft nodes before linearized reading' (duration: 244.138546ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T23:41:55.697236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.986413ms","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-07-08T23:41:55.69733Z","caller":"traceutil/trace.go:171","msg":"trace[462946583] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2770; }","duration":"246.132486ms","start":"2026-07-08T23:41:55.451174Z","end":"2026-07-08T23:41:55.697306Z","steps":["trace[462946583] 'agreement among raft nodes before linearized reading' (duration: 245.833079ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T23:45:59.888744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.349294ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-jz5hp-tls\" ","response":"range_response_count:1 size:1967"} {"level":"info","ts":"2026-07-08T23:45:59.888869Z","caller":"traceutil/trace.go:171","msg":"trace[1350048663] range","detail":"{range_begin:/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-jz5hp-tls; range_end:; response_count:1; response_revision:4977; }","duration":"196.539958ms","start":"2026-07-08T23:45:59.692303Z","end":"2026-07-08T23:45:59.888843Z","steps":["trace[1350048663] 'range keys from in-memory index tree' (duration: 196.11498ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T23:45:59.888731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.704285ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"warn","ts":"2026-07-08T23:45:59.889031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.513319ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:24 size:728883"} {"level":"info","ts":"2026-07-08T23:45:59.889157Z","caller":"traceutil/trace.go:171","msg":"trace[857096118] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:24; response_revision:4977; }","duration":"130.707682ms","start":"2026-07-08T23:45:59.758426Z","end":"2026-07-08T23:45:59.889134Z","steps":["trace[857096118] 'range keys from in-memory index tree' (duration: 129.854405ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T23:45:59.889217Z","caller":"traceutil/trace.go:171","msg":"trace[1003801741] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4977; }","duration":"190.035021ms","start":"2026-07-08T23:45:59.698979Z","end":"2026-07-08T23:45:59.889014Z","steps":["trace[1003801741] 'range keys from in-memory index tree' (duration: 189.542432ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T23:46:10.060265Z","caller":"traceutil/trace.go:171","msg":"trace[927857174] transaction","detail":"{read_only:false; response_revision:5196; number_of_response:1; }","duration":"103.526456ms","start":"2026-07-08T23:46:09.956708Z","end":"2026-07-08T23:46:10.060234Z","steps":["trace[927857174] 'process raft request' (duration: 102.443575ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T23:46:13.582106Z","caller":"traceutil/trace.go:171","msg":"trace[1772186123] linearizableReadLoop","detail":"{readStateIndex:5477; appliedIndex:5476; }","duration":"109.877799ms","start":"2026-07-08T23:46:13.472199Z","end":"2026-07-08T23:46:13.582076Z","steps":["trace[1772186123] 'read index received' (duration: 109.659585ms)","trace[1772186123] 'applied index is now lower than readState.Index' (duration: 216.894µs)"],"step_count":2} {"level":"info","ts":"2026-07-08T23:46:13.582157Z","caller":"traceutil/trace.go:171","msg":"trace[1699093300] transaction","detail":"{read_only:false; response_revision:5277; number_of_response:1; }","duration":"111.447288ms","start":"2026-07-08T23:46:13.47065Z","end":"2026-07-08T23:46:13.582097Z","steps":["trace[1699093300] 'process raft request' (duration: 111.166613ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T23:46:13.582384Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.163754ms","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-07-08T23:46:13.58245Z","caller":"traceutil/trace.go:171","msg":"trace[940820791] range","detail":"{range_begin:/registry/services/specs/monitoring/prometheus-operated; range_end:; response_count:1; response_revision:5277; }","duration":"110.254506ms","start":"2026-07-08T23:46:13.47218Z","end":"2026-07-08T23:46:13.582435Z","steps":["trace[940820791] 'agreement among raft nodes before linearized reading' (duration: 109.987891ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T23:46:13.735496Z","caller":"traceutil/trace.go:171","msg":"trace[107511952] transaction","detail":"{read_only:false; response_revision:5283; number_of_response:1; }","duration":"132.744161ms","start":"2026-07-08T23:46:13.602722Z","end":"2026-07-08T23:46:13.735466Z","steps":["trace[107511952] 'process raft request' (duration: 132.536887ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T23:46:13.735511Z","caller":"traceutil/trace.go:171","msg":"trace[501334258] transaction","detail":"{read_only:false; response_revision:5282; number_of_response:1; }","duration":"133.001776ms","start":"2026-07-08T23:46:13.602459Z","end":"2026-07-08T23:46:13.73546Z","steps":["trace[501334258] 'process raft request' (duration: 50.396166ms)","trace[501334258] 'compare' (duration: 82.212972ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T23:46:13.735548Z","caller":"traceutil/trace.go:171","msg":"trace[234577880] linearizableReadLoop","detail":"{readStateIndex:5483; appliedIndex:5479; }","duration":"130.560949ms","start":"2026-07-08T23:46:13.604965Z","end":"2026-07-08T23:46:13.735526Z","steps":["trace[234577880] 'read index received' (duration: 31.152074ms)","trace[234577880] 'applied index is now lower than readState.Index' (duration: 99.407625ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T23:46:13.736499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.496647ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" ","response":"range_response_count:16 size:110435"} {"level":"info","ts":"2026-07-08T23:46:13.736579Z","caller":"traceutil/trace.go:171","msg":"trace[172739599] range","detail":"{range_begin:/registry/pods/monitoring/; range_end:/registry/pods/monitoring0; response_count:16; response_revision:5284; }","duration":"131.62536ms","start":"2026-07-08T23:46:13.604935Z","end":"2026-07-08T23:46:13.73656Z","steps":["trace[172739599] 'agreement among raft nodes before linearized reading' (duration: 130.817194ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T23:46:14.203776Z","caller":"traceutil/trace.go:171","msg":"trace[73447990] linearizableReadLoop","detail":"{readStateIndex:5487; appliedIndex:5486; }","duration":"187.33393ms","start":"2026-07-08T23:46:14.016409Z","end":"2026-07-08T23:46:14.203743Z","steps":["trace[73447990] 'read index received' (duration: 187.121306ms)","trace[73447990] 'applied index is now lower than readState.Index' (duration: 210.694µs)"],"step_count":2} {"level":"warn","ts":"2026-07-08T23:46:14.203961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.527083ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T23:46:14.204042Z","caller":"traceutil/trace.go:171","msg":"trace[800314350] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5286; }","duration":"187.647546ms","start":"2026-07-08T23:46:14.016376Z","end":"2026-07-08T23:46:14.204023Z","steps":["trace[800314350] 'agreement among raft nodes before linearized reading' (duration: 187.485503ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T23:46:14.204132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.979291ms","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-07-08T23:46:14.204214Z","caller":"traceutil/trace.go:171","msg":"trace[1572338806] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5286; }","duration":"125.144984ms","start":"2026-07-08T23:46:14.079049Z","end":"2026-07-08T23:46:14.204194Z","steps":["trace[1572338806] 'agreement among raft nodes before linearized reading' (duration: 124.89149ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T23:46:14.551067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.968136ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-08T23:46:14.551321Z","caller":"traceutil/trace.go:171","msg":"trace[1455457110] linearizableReadLoop","detail":"{readStateIndex:5488; appliedIndex:5487; }","duration":"343.620486ms","start":"2026-07-08T23:46:14.207674Z","end":"2026-07-08T23:46:14.551294Z","steps":["trace[1455457110] 'read index received' (duration: 178.079089ms)","trace[1455457110] 'applied index is now lower than readState.Index' (duration: 165.538877ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T23:46:14.551467Z","caller":"traceutil/trace.go:171","msg":"trace[862335408] transaction","detail":"{read_only:false; response_revision:5287; number_of_response:1; }","duration":"346.314209ms","start":"2026-07-08T23:46:14.205087Z","end":"2026-07-08T23:46:14.551401Z","steps":["trace[862335408] 'process raft request' (duration: 180.6358ms)","trace[862335408] 'compare' (duration: 164.399075ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T23:46:14.55161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.928053ms","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-07-08T23:46:14.551657Z","caller":"traceutil/trace.go:171","msg":"trace[1005771457] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5287; }","duration":"343.978484ms","start":"2026-07-08T23:46:14.207667Z","end":"2026-07-08T23:46:14.551646Z","steps":["trace[1005771457] 'agreement among raft nodes before linearized reading' (duration: 343.733469ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T23:46:14.551697Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T23:46:14.207627Z","time spent":"344.060605ms","remote":"127.0.0.1:44144","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12234,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-07-08T23:46:14.551733Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T23:46:14.20506Z","time spent":"346.524133ms","remote":"127.0.0.1:44000","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T23:46:14.582487Z","caller":"traceutil/trace.go:171","msg":"trace[2072728119] transaction","detail":"{read_only:false; response_revision:5288; number_of_response:1; }","duration":"374.557506ms","start":"2026-07-08T23:46:14.207904Z","end":"2026-07-08T23:46:14.582462Z","steps":["trace[2072728119] 'process raft request' (duration: 374.303511ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T23:46:14.582521Z","caller":"traceutil/trace.go:171","msg":"trace[795635077] transaction","detail":"{read_only:false; response_revision:5289; number_of_response:1; }","duration":"325.282362ms","start":"2026-07-08T23:46:14.257203Z","end":"2026-07-08T23:46:14.582486Z","steps":["trace[795635077] 'process raft request' (duration: 325.18774ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T23:46:14.582632Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T23:46:14.207881Z","time spent":"374.678169ms","remote":"127.0.0.1:44232","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-08T23:46:14.58268Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T23:46:14.257187Z","time spent":"325.415666ms","remote":"127.0.0.1:44036","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":812,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-08T23:46:14.582756Z","caller":"traceutil/trace.go:171","msg":"trace[1125092421] transaction","detail":"{read_only:false; response_revision:5290; number_of_response:1; }","duration":"246.020197ms","start":"2026-07-08T23:46:14.336678Z","end":"2026-07-08T23:46:14.582698Z","steps":["trace[1125092421] 'process raft request' (duration: 245.768441ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T23:46:14.583614Z","caller":"traceutil/trace.go:171","msg":"trace[28065579] transaction","detail":"{read_only:false; response_revision:5291; number_of_response:1; }","duration":"128.769814ms","start":"2026-07-08T23:46:14.45482Z","end":"2026-07-08T23:46:14.58359Z","steps":["trace[28065579] 'process raft request' (duration: 128.52792ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T23:46:14.583866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"349.000662ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-08T23:46:14.583951Z","caller":"traceutil/trace.go:171","msg":"trace[1257459118] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:5292; }","duration":"349.120584ms","start":"2026-07-08T23:46:14.234816Z","end":"2026-07-08T23:46:14.583937Z","steps":["trace[1257459118] 'agreement among raft nodes before linearized reading' (duration: 348.937091ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T23:46:14.583994Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T23:46:14.234805Z","time spent":"349.179336ms","remote":"127.0.0.1:44054","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":59,"response size":29,"request content":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true "} {"level":"info","ts":"2026-07-08T23:46:21.725506Z","caller":"traceutil/trace.go:171","msg":"trace[1943095299] transaction","detail":"{read_only:false; response_revision:5450; number_of_response:1; }","duration":"135.206899ms","start":"2026-07-08T23:46:21.590265Z","end":"2026-07-08T23:46:21.725472Z","steps":["trace[1943095299] 'process raft request' (duration: 134.994245ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T23:46:21.747257Z","caller":"traceutil/trace.go:171","msg":"trace[547133786] transaction","detail":"{read_only:false; response_revision:5451; number_of_response:1; }","duration":"133.284003ms","start":"2026-07-08T23:46:21.613938Z","end":"2026-07-08T23:46:21.747222Z","steps":["trace[547133786] 'process raft request' (duration: 132.985207ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T23:47:31.020745Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2963} {"level":"info","ts":"2026-07-08T23:47:31.090255Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2963,"took":"67.805165ms","hash":3888548266,"current-db-size-bytes":59224064,"current-db-size":"59 MB","current-db-size-in-use-bytes":34177024,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-07-08T23:47:31.090385Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3888548266,"revision":2963,"compact-revision":-1} {"level":"info","ts":"2026-07-08T23:52:31.027192Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6056} {"level":"info","ts":"2026-07-08T23:52:31.177702Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6056,"took":"148.784582ms","hash":857822866,"current-db-size-bytes":59224064,"current-db-size":"59 MB","current-db-size-in-use-bytes":21819392,"current-db-size-in-use":"22 MB"} {"level":"info","ts":"2026-07-08T23:52:31.177784Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":857822866,"revision":6056,"compact-revision":2963} {"level":"info","ts":"2026-07-08T23:52:58.100278Z","caller":"traceutil/trace.go:171","msg":"trace[1890974357] transaction","detail":"{read_only:false; response_revision:8394; number_of_response:1; }","duration":"145.200236ms","start":"2026-07-08T23:52:57.955043Z","end":"2026-07-08T23:52:58.100243Z","steps":["trace[1890974357] 'process raft request' (duration: 144.844319ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T23:53:26.961507Z","caller":"traceutil/trace.go:171","msg":"trace[1596402237] transaction","detail":"{read_only:false; response_revision:8604; number_of_response:1; }","duration":"188.466793ms","start":"2026-07-08T23:53:26.773003Z","end":"2026-07-08T23:53:26.96147Z","steps":["trace[1596402237] 'process raft request' (duration: 188.262529ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T23:53:30.580143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.654882ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-08T23:53:30.580279Z","caller":"traceutil/trace.go:171","msg":"trace[1218505168] transaction","detail":"{read_only:false; response_revision:8619; number_of_response:1; }","duration":"268.47615ms","start":"2026-07-08T23:53:30.311777Z","end":"2026-07-08T23:53:30.580254Z","steps":["trace[1218505168] 'process raft request' (duration: 136.585744ms)","trace[1218505168] 'compare' (duration: 131.486719ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T23:53:30.589541Z","caller":"traceutil/trace.go:171","msg":"trace[544502526] linearizableReadLoop","detail":"{readStateIndex:8927; appliedIndex:8925; }","duration":"243.021701ms","start":"2026-07-08T23:53:30.346502Z","end":"2026-07-08T23:53:30.589524Z","steps":["trace[544502526] 'read index received' (duration: 101.9083ms)","trace[544502526] 'applied index is now lower than readState.Index' (duration: 141.112561ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T23:53:30.589694Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.176244ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-08T23:53:30.589652Z","caller":"traceutil/trace.go:171","msg":"trace[1055327482] transaction","detail":"{read_only:false; response_revision:8620; number_of_response:1; }","duration":"252.089852ms","start":"2026-07-08T23:53:30.337485Z","end":"2026-07-08T23:53:30.589575Z","steps":["trace[1055327482] 'process raft request' (duration: 251.847667ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T23:53:30.589744Z","caller":"traceutil/trace.go:171","msg":"trace[868520091] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:8622; }","duration":"243.263716ms","start":"2026-07-08T23:53:30.346463Z","end":"2026-07-08T23:53:30.589727Z","steps":["trace[868520091] 'agreement among raft nodes before linearized reading' (duration: 243.132043ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T23:53:30.589803Z","caller":"traceutil/trace.go:171","msg":"trace[613959604] transaction","detail":"{read_only:false; response_revision:8622; number_of_response:1; }","duration":"237.541908ms","start":"2026-07-08T23:53:30.35221Z","end":"2026-07-08T23:53:30.589752Z","steps":["trace[613959604] 'process raft request' (duration: 237.275403ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T23:53:30.589823Z","caller":"traceutil/trace.go:171","msg":"trace[543015407] transaction","detail":"{read_only:false; response_revision:8621; number_of_response:1; }","duration":"241.37662ms","start":"2026-07-08T23:53:30.348408Z","end":"2026-07-08T23:53:30.589785Z","steps":["trace[543015407] 'process raft request' (duration: 241.032993ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T23:53:30.991746Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000022e3.wal"} {"level":"info","ts":"2026-07-08T23:53:38.986668Z","caller":"traceutil/trace.go:171","msg":"trace[946998643] linearizableReadLoop","detail":"{readStateIndex:9020; appliedIndex:9016; }","duration":"362.592824ms","start":"2026-07-08T23:53:38.62405Z","end":"2026-07-08T23:53:38.986643Z","steps":["trace[946998643] 'read index received' (duration: 23.969041ms)","trace[946998643] 'applied index is now lower than readState.Index' (duration: 338.622463ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T23:53:38.986737Z","caller":"traceutil/trace.go:171","msg":"trace[2122375739] transaction","detail":"{read_only:false; response_revision:8708; number_of_response:1; }","duration":"363.475232ms","start":"2026-07-08T23:53:38.62324Z","end":"2026-07-08T23:53:38.986715Z","steps":["trace[2122375739] 'process raft request' (duration: 363.352599ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T23:53:38.986672Z","caller":"traceutil/trace.go:171","msg":"trace[1372561384] transaction","detail":"{read_only:false; response_revision:8706; number_of_response:1; }","duration":"364.750615ms","start":"2026-07-08T23:53:38.621902Z","end":"2026-07-08T23:53:38.986653Z","steps":["trace[1372561384] 'process raft request' (duration: 364.4786ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T23:53:38.986733Z","caller":"traceutil/trace.go:171","msg":"trace[413663207] transaction","detail":"{read_only:false; response_revision:8707; number_of_response:1; }","duration":"364.548841ms","start":"2026-07-08T23:53:38.622148Z","end":"2026-07-08T23:53:38.986697Z","steps":["trace[413663207] 'process raft request' (duration: 364.401388ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T23:53:38.986872Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T23:53:38.623212Z","time spent":"363.585034ms","remote":"127.0.0.1:44232","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":514,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-08T23:53:38.986894Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T23:53:38.621891Z","time spent":"364.921148ms","remote":"127.0.0.1:44232","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-08T23:53:38.986914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"362.87269ms","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-07-08T23:53:38.986948Z","caller":"traceutil/trace.go:171","msg":"trace[1685610222] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8708; }","duration":"362.954501ms","start":"2026-07-08T23:53:38.623987Z","end":"2026-07-08T23:53:38.986941Z","steps":["trace[1685610222] 'agreement among raft nodes before linearized reading' (duration: 362.738317ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T23:53:38.986941Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T23:53:38.622107Z","time spent":"364.738935ms","remote":"127.0.0.1:44232","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-08T23:53:38.98719Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T23:53:38.623969Z","time spent":"363.004482ms","remote":"127.0.0.1:44232","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-07-08T23:53:40.003433Z","caller":"traceutil/trace.go:171","msg":"trace[825326757] transaction","detail":"{read_only:false; response_revision:8716; number_of_response:1; }","duration":"128.710196ms","start":"2026-07-08T23:53:39.87468Z","end":"2026-07-08T23:53:40.00339Z","steps":["trace[825326757] 'process raft request' (duration: 128.428771ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T23:54:57.494597Z","caller":"traceutil/trace.go:171","msg":"trace[2074139577] transaction","detail":"{read_only:false; response_revision:9467; number_of_response:1; }","duration":"221.261941ms","start":"2026-07-08T23:54:57.273304Z","end":"2026-07-08T23:54:57.494566Z","steps":["trace[2074139577] 'process raft request' (duration: 221.045227ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T23:54:57.622582Z","caller":"traceutil/trace.go:171","msg":"trace[501770817] linearizableReadLoop","detail":"{readStateIndex:9800; appliedIndex:9798; }","duration":"219.715832ms","start":"2026-07-08T23:54:57.40284Z","end":"2026-07-08T23:54:57.622556Z","steps":["trace[501770817] 'read index received' (duration: 91.510645ms)","trace[501770817] 'applied index is now lower than readState.Index' (duration: 128.204057ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T23:54:57.622651Z","caller":"traceutil/trace.go:171","msg":"trace[1275122858] transaction","detail":"{read_only:false; response_revision:9468; number_of_response:1; }","duration":"337.582514ms","start":"2026-07-08T23:54:57.285042Z","end":"2026-07-08T23:54:57.622625Z","steps":["trace[1275122858] 'process raft request' (duration: 337.34976ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T23:54:57.622798Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T23:54:57.285005Z","time spent":"337.694766ms","remote":"127.0.0.1:44232","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-08T23:54:57.622825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.987798ms","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-07-08T23:54:57.622867Z","caller":"traceutil/trace.go:171","msg":"trace[1390871678] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:9468; }","duration":"220.088539ms","start":"2026-07-08T23:54:57.402768Z","end":"2026-07-08T23:54:57.622856Z","steps":["trace[1390871678] 'agreement among raft nodes before linearized reading' (duration: 219.921186ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T23:54:57.622996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.024288ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-07-08T23:54:57.623105Z","caller":"traceutil/trace.go:171","msg":"trace[1864547571] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:9468; }","duration":"220.214112ms","start":"2026-07-08T23:54:57.40287Z","end":"2026-07-08T23:54:57.623084Z","steps":["trace[1864547571] 'agreement among raft nodes before linearized reading' (duration: 219.872145ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T23:55:23.901546Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"7c53a18098324dc9","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-07-08T23:55:23.908286Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-07-08T23:55:23.908402Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-07-08T23:57:31.034118Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8115} {"level":"info","ts":"2026-07-08T23:57:31.100054Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8115,"took":"63.168482ms","hash":3791646025,"current-db-size-bytes":59224064,"current-db-size":"59 MB","current-db-size-in-use-bytes":27983872,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-07-08T23:57:31.100113Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3791646025,"revision":8115,"compact-revision":6056} {"level":"info","ts":"2026-07-09T00:00:39.740227Z","caller":"traceutil/trace.go:171","msg":"trace[780396146] linearizableReadLoop","detail":"{readStateIndex:12368; appliedIndex:12366; }","duration":"154.165622ms","start":"2026-07-09T00:00:39.586033Z","end":"2026-07-09T00:00:39.740199Z","steps":["trace[780396146] 'read index received' (duration: 37.738556ms)","trace[780396146] 'applied index is now lower than readState.Index' (duration: 116.425936ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T00:00:39.740326Z","caller":"traceutil/trace.go:171","msg":"trace[966636809] transaction","detail":"{read_only:false; response_revision:11955; number_of_response:1; }","duration":"190.51592ms","start":"2026-07-09T00:00:39.54977Z","end":"2026-07-09T00:00:39.740286Z","steps":["trace[966636809] 'process raft request' (duration: 169.196721ms)","trace[966636809] 'compare' (duration: 21.016573ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T00:00:39.740399Z","caller":"traceutil/trace.go:171","msg":"trace[1921435797] transaction","detail":"{read_only:false; response_revision:11956; number_of_response:1; }","duration":"188.894349ms","start":"2026-07-09T00:00:39.551485Z","end":"2026-07-09T00:00:39.74038Z","steps":["trace[1921435797] 'process raft request' (duration: 188.652564ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T00:00:39.7407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.633101ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/orders/\" range_end:\"/registry/acme.cert-manager.io/orders0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-09T00:00:39.740795Z","caller":"traceutil/trace.go:171","msg":"trace[143114232] range","detail":"{range_begin:/registry/acme.cert-manager.io/orders/; range_end:/registry/acme.cert-manager.io/orders0; response_count:0; response_revision:11956; }","duration":"154.744073ms","start":"2026-07-09T00:00:39.586026Z","end":"2026-07-09T00:00:39.74077Z","steps":["trace[143114232] 'agreement among raft nodes before linearized reading' (duration: 154.59364ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T00:00:40.669514Z","caller":"traceutil/trace.go:171","msg":"trace[2121098470] transaction","detail":"{read_only:false; response_revision:11960; number_of_response:1; }","duration":"130.983457ms","start":"2026-07-09T00:00:40.538485Z","end":"2026-07-09T00:00:40.669469Z","steps":["trace[2121098470] 'process raft request' (duration: 130.745143ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T00:02:31.040763Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10481} {"level":"info","ts":"2026-07-09T00:02:31.120538Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10481,"took":"76.87678ms","hash":4112815488,"current-db-size-bytes":59224064,"current-db-size":"59 MB","current-db-size-in-use-bytes":26427392,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-07-09T00:02:31.120611Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4112815488,"revision":10481,"compact-revision":8115} {"level":"info","ts":"2026-07-09T00:06:43.994969Z","caller":"traceutil/trace.go:171","msg":"trace[1543154050] transaction","detail":"{read_only:false; response_revision:14453; number_of_response:1; }","duration":"116.411809ms","start":"2026-07-09T00:06:43.878522Z","end":"2026-07-09T00:06:43.994934Z","steps":["trace[1543154050] 'process raft request' (duration: 116.201905ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T00:07:19.890942Z","caller":"traceutil/trace.go:171","msg":"trace[1944442592] linearizableReadLoop","detail":"{readStateIndex:15161; appliedIndex:15160; }","duration":"118.515069ms","start":"2026-07-09T00:07:19.772406Z","end":"2026-07-09T00:07:19.890921Z","steps":["trace[1944442592] 'read index received' (duration: 118.361206ms)","trace[1944442592] 'applied index is now lower than readState.Index' (duration: 152.993µs)"],"step_count":2} {"level":"info","ts":"2026-07-09T00:07:19.891013Z","caller":"traceutil/trace.go:171","msg":"trace[18402128] transaction","detail":"{read_only:false; response_revision:14653; number_of_response:1; }","duration":"149.866907ms","start":"2026-07-09T00:07:19.741105Z","end":"2026-07-09T00:07:19.890972Z","steps":["trace[18402128] 'process raft request' (duration: 149.676673ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T00:07:19.891244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.820115ms","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-07-09T00:07:19.891318Z","caller":"traceutil/trace.go:171","msg":"trace[1957362445] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:14653; }","duration":"118.969768ms","start":"2026-07-09T00:07:19.772334Z","end":"2026-07-09T00:07:19.891304Z","steps":["trace[1957362445] 'agreement among raft nodes before linearized reading' (duration: 118.667762ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T00:07:29.993473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.201649ms","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-07-09T00:07:29.99359Z","caller":"traceutil/trace.go:171","msg":"trace[532277068] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:14824; }","duration":"280.334601ms","start":"2026-07-09T00:07:29.713214Z","end":"2026-07-09T00:07:29.993549Z","steps":["trace[532277068] 'range keys from in-memory index tree' (duration: 280.122678ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T00:07:31.04703Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12705} {"level":"info","ts":"2026-07-09T00:07:31.123637Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12705,"took":"73.731305ms","hash":2256072914,"current-db-size-bytes":59224064,"current-db-size":"59 MB","current-db-size-in-use-bytes":28844032,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-07-09T00:07:31.123698Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2256072914,"revision":12705,"compact-revision":10481} {"level":"info","ts":"2026-07-09T00:09:10.648623Z","caller":"traceutil/trace.go:171","msg":"trace[1969018279] transaction","detail":"{read_only:false; response_revision:15915; number_of_response:1; }","duration":"260.754975ms","start":"2026-07-09T00:09:10.387846Z","end":"2026-07-09T00:09:10.648601Z","steps":["trace[1969018279] 'process raft request' (duration: 260.613462ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T00:09:10.649027Z","caller":"traceutil/trace.go:171","msg":"trace[944972240] linearizableReadLoop","detail":"{readStateIndex:16460; appliedIndex:16460; }","duration":"184.973612ms","start":"2026-07-09T00:09:10.464029Z","end":"2026-07-09T00:09:10.649002Z","steps":["trace[944972240] 'read index received' (duration: 184.880361ms)","trace[944972240] 'applied index is now lower than readState.Index' (duration: 91.021µs)"],"step_count":2} {"level":"warn","ts":"2026-07-09T00:09:10.649178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.131745ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-09T00:09:10.649239Z","caller":"traceutil/trace.go:171","msg":"trace[1553121537] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:15915; }","duration":"185.266767ms","start":"2026-07-09T00:09:10.46395Z","end":"2026-07-09T00:09:10.649217Z","steps":["trace[1553121537] 'agreement among raft nodes before linearized reading' (duration: 185.169375ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T00:09:10.84795Z","caller":"traceutil/trace.go:171","msg":"trace[1618667351] linearizableReadLoop","detail":"{readStateIndex:16461; appliedIndex:16460; }","duration":"198.841966ms","start":"2026-07-09T00:09:10.649091Z","end":"2026-07-09T00:09:10.847933Z","steps":["trace[1618667351] 'read index received' (duration: 135.402818ms)","trace[1618667351] 'applied index is now lower than readState.Index' (duration: 63.437658ms)"],"step_count":2} {"level":"warn","ts":"2026-07-09T00:09:10.848405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.036392ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5521"} {"level":"info","ts":"2026-07-09T00:09:10.848456Z","caller":"traceutil/trace.go:171","msg":"trace[1575939048] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:15916; }","duration":"238.121134ms","start":"2026-07-09T00:09:10.610322Z","end":"2026-07-09T00:09:10.848443Z","steps":["trace[1575939048] 'agreement among raft nodes before linearized reading' (duration: 237.966211ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T00:09:10.848453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.565834ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-9nfxl\" ","response":"range_response_count:1 size:22092"} {"level":"warn","ts":"2026-07-09T00:09:10.848497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.737994ms","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-07-09T00:09:10.848488Z","caller":"traceutil/trace.go:171","msg":"trace[1942559707] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-9nfxl; range_end:; response_count:1; response_revision:15916; }","duration":"289.616794ms","start":"2026-07-09T00:09:10.558861Z","end":"2026-07-09T00:09:10.848478Z","steps":["trace[1942559707] 'agreement among raft nodes before linearized reading' (duration: 289.458741ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T00:09:10.848499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.569118ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-9nfxl\" ","response":"range_response_count:1 size:22092"} {"level":"info","ts":"2026-07-09T00:09:10.848551Z","caller":"traceutil/trace.go:171","msg":"trace[571683093] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:15916; }","duration":"302.799775ms","start":"2026-07-09T00:09:10.545728Z","end":"2026-07-09T00:09:10.848527Z","steps":["trace[571683093] 'agreement among raft nodes before linearized reading' (duration: 302.705953ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T00:09:10.848573Z","caller":"traceutil/trace.go:171","msg":"trace[362765922] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-9nfxl; range_end:; response_count:1; response_revision:15916; }","duration":"294.674621ms","start":"2026-07-09T00:09:10.553876Z","end":"2026-07-09T00:09:10.848551Z","steps":["trace[362765922] 'agreement among raft nodes before linearized reading' (duration: 294.430646ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T00:09:10.84859Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T00:09:10.545717Z","time spent":"302.866066ms","remote":"127.0.0.1:44232","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-07-09T00:09:10.848822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.884366ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-09T00:09:10.848875Z","caller":"traceutil/trace.go:171","msg":"trace[1720160541] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:15916; }","duration":"231.960037ms","start":"2026-07-09T00:09:10.616907Z","end":"2026-07-09T00:09:10.848867Z","steps":["trace[1720160541] 'agreement among raft nodes before linearized reading' (duration: 231.881105ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T00:09:10.848913Z","caller":"traceutil/trace.go:171","msg":"trace[507038671] transaction","detail":"{read_only:false; response_revision:15916; number_of_response:1; }","duration":"332.510311ms","start":"2026-07-09T00:09:10.51639Z","end":"2026-07-09T00:09:10.8489Z","steps":["trace[507038671] 'process raft request' (duration: 268.156716ms)","trace[507038671] 'compare' (duration: 63.254195ms)"],"step_count":2} {"level":"warn","ts":"2026-07-09T00:09:10.849008Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T00:09:10.516372Z","time spent":"332.574133ms","remote":"127.0.0.1:44232","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":544,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-09T00:09:10.849216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"374.235895ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5521"} {"level":"info","ts":"2026-07-09T00:09:10.849261Z","caller":"traceutil/trace.go:171","msg":"trace[1288966681] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:15916; }","duration":"374.324467ms","start":"2026-07-09T00:09:10.474929Z","end":"2026-07-09T00:09:10.849254Z","steps":["trace[1288966681] 'agreement among raft nodes before linearized reading' (duration: 374.209745ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T00:09:10.8493Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.357406ms","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-07-09T00:09:10.849347Z","caller":"traceutil/trace.go:171","msg":"trace[1248071245] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:15916; }","duration":"313.436428ms","start":"2026-07-09T00:09:10.535899Z","end":"2026-07-09T00:09:10.849336Z","steps":["trace[1248071245] 'agreement among raft nodes before linearized reading' (duration: 313.320586ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T00:09:10.849382Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T00:09:10.535887Z","time spent":"313.488269ms","remote":"127.0.0.1:44232","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-09T00:09:10.84951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"384.774816ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:668"} {"level":"info","ts":"2026-07-09T00:09:10.84955Z","caller":"traceutil/trace.go:171","msg":"trace[767263732] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:15916; }","duration":"384.842797ms","start":"2026-07-09T00:09:10.464697Z","end":"2026-07-09T00:09:10.84954Z","steps":["trace[767263732] 'agreement among raft nodes before linearized reading' (duration: 384.655744ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T00:09:10.849576Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T00:09:10.464686Z","time spent":"384.883549ms","remote":"127.0.0.1:44130","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":690,"request content":"key:\"/registry/services/endpoints/openstack/nova-api\" "} {"level":"warn","ts":"2026-07-09T00:09:10.848383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.586736ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-07-09T00:09:10.849766Z","caller":"traceutil/trace.go:171","msg":"trace[2070748969] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:15916; }","duration":"310.008982ms","start":"2026-07-09T00:09:10.539745Z","end":"2026-07-09T00:09:10.849754Z","steps":["trace[2070748969] 'agreement among raft nodes before linearized reading' (duration: 308.377592ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T00:09:10.84981Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T00:09:10.539734Z","time spent":"310.062893ms","remote":"127.0.0.1:44232","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-07-09T00:09:10.849285Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T00:09:10.474902Z","time spent":"374.377667ms","remote":"127.0.0.1:44204","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":5543,"request content":"key:\"/registry/jobs/openstack/nova-db-sync\" "} {"level":"warn","ts":"2026-07-09T00:09:10.850159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.785991ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-07-09T00:09:10.850193Z","caller":"traceutil/trace.go:171","msg":"trace[1053375330] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:15916; }","duration":"339.847691ms","start":"2026-07-09T00:09:10.510336Z","end":"2026-07-09T00:09:10.850184Z","steps":["trace[1053375330] 'agreement among raft nodes before linearized reading' (duration: 339.746879ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T00:09:10.85022Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T00:09:10.510323Z","time spent":"339.891253ms","remote":"127.0.0.1:44232","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-07-09T00:12:16.416414Z","caller":"traceutil/trace.go:171","msg":"trace[1687178432] transaction","detail":"{read_only:false; response_revision:17372; number_of_response:1; }","duration":"103.039731ms","start":"2026-07-09T00:12:16.313344Z","end":"2026-07-09T00:12:16.416384Z","steps":["trace[1687178432] 'process raft request' (duration: 43.758856ms)","trace[1687178432] 'compare' (duration: 58.814057ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T00:12:31.053893Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14839} {"level":"info","ts":"2026-07-09T00:12:31.154747Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14839,"took":"98.15113ms","hash":3178782354,"current-db-size-bytes":59224064,"current-db-size":"59 MB","current-db-size-in-use-bytes":30879744,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-07-09T00:12:31.154843Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3178782354,"revision":14839,"compact-revision":12705} {"level":"info","ts":"2026-07-09T00:14:52.057805Z","caller":"traceutil/trace.go:171","msg":"trace[962134341] transaction","detail":"{read_only:false; response_revision:18423; number_of_response:1; }","duration":"332.987561ms","start":"2026-07-09T00:14:51.724773Z","end":"2026-07-09T00:14:52.057761Z","steps":["trace[962134341] 'process raft request' (duration: 332.646974ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T00:14:52.058062Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T00:14:51.724745Z","time spent":"333.181834ms","remote":"127.0.0.1:44144","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":20855,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-09T00:14:52.274843Z","caller":"traceutil/trace.go:171","msg":"trace[1005808620] transaction","detail":"{read_only:false; response_revision:18424; number_of_response:1; }","duration":"483.544088ms","start":"2026-07-09T00:14:51.791274Z","end":"2026-07-09T00:14:52.274818Z","steps":["trace[1005808620] 'process raft request' (duration: 483.1068ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T00:14:52.275024Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T00:14:51.791239Z","time spent":"483.698192ms","remote":"127.0.0.1:46290","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417109,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-09T00:14:52.275104Z","caller":"traceutil/trace.go:171","msg":"trace[1093588449] transaction","detail":"{read_only:false; response_revision:18425; number_of_response:1; }","duration":"354.074261ms","start":"2026-07-09T00:14:51.921006Z","end":"2026-07-09T00:14:52.275081Z","steps":["trace[1093588449] 'process raft request' (duration: 353.747145ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T00:14:52.275243Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T00:14:51.920985Z","time spent":"354.185654ms","remote":"127.0.0.1:44232","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-09T00:14:52.275365Z","caller":"traceutil/trace.go:171","msg":"trace[1453041107] transaction","detail":"{read_only:false; response_revision:18426; number_of_response:1; }","duration":"245.847826ms","start":"2026-07-09T00:14:52.029509Z","end":"2026-07-09T00:14:52.275356Z","steps":["trace[1453041107] 'process raft request' (duration: 245.469319ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T00:14:52.698467Z","caller":"traceutil/trace.go:171","msg":"trace[2049863053] transaction","detail":"{read_only:false; response_revision:18427; number_of_response:1; }","duration":"411.42607ms","start":"2026-07-09T00:14:52.286998Z","end":"2026-07-09T00:14:52.698424Z","steps":["trace[2049863053] 'process raft request' (duration: 411.202826ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T00:14:52.698699Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T00:14:52.286972Z","time spent":"411.600193ms","remote":"127.0.0.1:44232","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-09T00:14:52.910534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.842114ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-09T00:14:52.910675Z","caller":"traceutil/trace.go:171","msg":"trace[1579151159] transaction","detail":"{read_only:false; response_revision:18428; number_of_response:1; }","duration":"534.257712ms","start":"2026-07-09T00:14:52.376398Z","end":"2026-07-09T00:14:52.910656Z","steps":["trace[1579151159] 'process raft request' (duration: 374.164953ms)","trace[1579151159] 'compare' (duration: 159.701282ms)"],"step_count":2} {"level":"warn","ts":"2026-07-09T00:14:52.910731Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T00:14:52.376374Z","time spent":"534.335313ms","remote":"127.0.0.1:44232","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-09T00:14:52.910858Z","caller":"traceutil/trace.go:171","msg":"trace[2023922509] transaction","detail":"{read_only:false; response_revision:18429; number_of_response:1; }","duration":"524.070657ms","start":"2026-07-09T00:14:52.386772Z","end":"2026-07-09T00:14:52.910843Z","steps":["trace[2023922509] 'process raft request' (duration: 523.852033ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T00:14:52.910928Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T00:14:52.386745Z","time spent":"524.151639ms","remote":"127.0.0.1:44232","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-09T00:14:52.910835Z","caller":"traceutil/trace.go:171","msg":"trace[1552323930] linearizableReadLoop","detail":"{readStateIndex:19056; appliedIndex:19053; }","duration":"356.932836ms","start":"2026-07-09T00:14:52.553871Z","end":"2026-07-09T00:14:52.910804Z","steps":["trace[1552323930] 'read index received' (duration: 144.313289ms)","trace[1552323930] 'applied index is now lower than readState.Index' (duration: 212.617727ms)"],"step_count":2} {"level":"warn","ts":"2026-07-09T00:14:52.911058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"357.17372ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-07-09T00:14:52.911117Z","caller":"traceutil/trace.go:171","msg":"trace[1361696208] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:18429; }","duration":"357.288942ms","start":"2026-07-09T00:14:52.553815Z","end":"2026-07-09T00:14:52.911104Z","steps":["trace[1361696208] 'agreement among raft nodes before linearized reading' (duration: 357.073788ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T00:14:52.911128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.472225ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/\" range_end:\"/registry/rabbitmq.com/rabbitmqclusters0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-07-09T00:14:52.91116Z","caller":"traceutil/trace.go:171","msg":"trace[1990243035] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/; range_end:/registry/rabbitmq.com/rabbitmqclusters0; response_count:0; response_revision:18429; }","duration":"200.540127ms","start":"2026-07-09T00:14:52.710609Z","end":"2026-07-09T00:14:52.911149Z","steps":["trace[1990243035] 'agreement among raft nodes before linearized reading' (duration: 200.481266ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T00:14:52.911159Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T00:14:52.553789Z","time spent":"357.360854ms","remote":"127.0.0.1:44232","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-09T00:14:52.911189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.078508ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-09T00:14:52.911278Z","caller":"traceutil/trace.go:171","msg":"trace[556413168] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:18429; }","duration":"308.249121ms","start":"2026-07-09T00:14:52.603008Z","end":"2026-07-09T00:14:52.911257Z","steps":["trace[556413168] 'agreement among raft nodes before linearized reading' (duration: 308.064448ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T00:14:52.911335Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T00:14:52.602979Z","time spent":"308.345412ms","remote":"127.0.0.1:35346","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true "} {"level":"warn","ts":"2026-07-09T00:14:52.911678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.995378ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-07-09T00:14:52.911714Z","caller":"traceutil/trace.go:171","msg":"trace[895066201] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:18429; }","duration":"297.049218ms","start":"2026-07-09T00:14:52.614656Z","end":"2026-07-09T00:14:52.911705Z","steps":["trace[895066201] 'agreement among raft nodes before linearized reading' (duration: 296.962877ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T00:14:52.911731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.771449ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-07-09T00:14:52.911775Z","caller":"traceutil/trace.go:171","msg":"trace[2111488338] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:18429; }","duration":"301.840649ms","start":"2026-07-09T00:14:52.609924Z","end":"2026-07-09T00:14:52.911764Z","steps":["trace[2111488338] 'agreement among raft nodes before linearized reading' (duration: 301.717797ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T00:14:52.91181Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T00:14:52.609909Z","time spent":"301.894191ms","remote":"127.0.0.1:44232","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-09T00:14:52.912137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.300414ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"info","ts":"2026-07-09T00:14:52.912262Z","caller":"traceutil/trace.go:171","msg":"trace[53740041] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:18429; }","duration":"295.479628ms","start":"2026-07-09T00:14:52.616752Z","end":"2026-07-09T00:14:52.912231Z","steps":["trace[53740041] 'agreement among raft nodes before linearized reading' (duration: 295.072531ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T00:15:51.282163Z","caller":"traceutil/trace.go:171","msg":"trace[1359060955] transaction","detail":"{read_only:false; response_revision:19148; number_of_response:1; }","duration":"143.040795ms","start":"2026-07-09T00:15:51.139075Z","end":"2026-07-09T00:15:51.282116Z","steps":["trace[1359060955] 'process raft request' (duration: 142.184439ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T00:16:17.437753Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"7c53a18098324dc9","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-07-09T00:16:17.445091Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-07-09T00:16:17.445205Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-07-09T00:17:31.05963Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17484} {"level":"info","ts":"2026-07-09T00:17:31.168694Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17484,"took":"99.600171ms","hash":514131876,"current-db-size-bytes":59224064,"current-db-size":"59 MB","current-db-size-in-use-bytes":34504704,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-07-09T00:17:31.168805Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":514131876,"revision":17484,"compact-revision":14839} {"level":"warn","ts":"2026-07-09T00:21:07.315189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.445826ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-09T00:21:07.315571Z","caller":"traceutil/trace.go:171","msg":"trace[482394316] linearizableReadLoop","detail":"{readStateIndex:22035; appliedIndex:22032; }","duration":"299.879652ms","start":"2026-07-09T00:21:07.015669Z","end":"2026-07-09T00:21:07.315549Z","steps":["trace[482394316] 'read index received' (duration: 2.965226ms)","trace[482394316] 'applied index is now lower than readState.Index' (duration: 296.912786ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T00:21:07.315562Z","caller":"traceutil/trace.go:171","msg":"trace[541204680] transaction","detail":"{read_only:false; response_revision:21312; number_of_response:1; }","duration":"303.471061ms","start":"2026-07-09T00:21:07.012044Z","end":"2026-07-09T00:21:07.315515Z","steps":["trace[541204680] 'compare' (duration: 295.330315ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T00:21:07.315631Z","caller":"traceutil/trace.go:171","msg":"trace[536004110] transaction","detail":"{read_only:false; response_revision:21313; number_of_response:1; }","duration":"302.474401ms","start":"2026-07-09T00:21:07.013106Z","end":"2026-07-09T00:21:07.315581Z","steps":["trace[536004110] 'process raft request' (duration: 302.252727ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T00:21:07.315654Z","caller":"traceutil/trace.go:171","msg":"trace[51807713] transaction","detail":"{read_only:false; response_revision:21314; number_of_response:1; }","duration":"302.390399ms","start":"2026-07-09T00:21:07.013194Z","end":"2026-07-09T00:21:07.315584Z","steps":["trace[51807713] 'process raft request' (duration: 302.308878ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T00:21:07.315722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.024664ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-09T00:21:07.315775Z","caller":"traceutil/trace.go:171","msg":"trace[1882547555] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:21314; }","duration":"300.113126ms","start":"2026-07-09T00:21:07.015645Z","end":"2026-07-09T00:21:07.315758Z","steps":["trace[1882547555] 'agreement among raft nodes before linearized reading' (duration: 299.976443ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T00:21:07.315814Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T00:21:07.015635Z","time spent":"300.170737ms","remote":"127.0.0.1:43970","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-07-09T00:21:07.31583Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T00:21:07.012005Z","time spent":"303.692574ms","remote":"127.0.0.1:44232","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-09T00:21:07.31589Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T00:21:07.013187Z","time spent":"302.582953ms","remote":"127.0.0.1:44232","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-09T00:21:07.315901Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T00:21:07.013072Z","time spent":"302.657064ms","remote":"127.0.0.1:44232","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-09T00:21:07.315907Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.686912ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-07-09T00:21:07.316024Z","caller":"traceutil/trace.go:171","msg":"trace[1692839984] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:21314; }","duration":"174.916486ms","start":"2026-07-09T00:21:07.141086Z","end":"2026-07-09T00:21:07.316002Z","steps":["trace[1692839984] 'agreement among raft nodes before linearized reading' (duration: 174.59856ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T00:21:08.634687Z","caller":"traceutil/trace.go:171","msg":"trace[1940444025] transaction","detail":"{read_only:false; response_revision:21318; number_of_response:1; }","duration":"122.480999ms","start":"2026-07-09T00:21:08.512166Z","end":"2026-07-09T00:21:08.634647Z","steps":["trace[1940444025] 'process raft request' (duration: 122.199673ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T00:21:08.668985Z","caller":"traceutil/trace.go:171","msg":"trace[69346047] transaction","detail":"{read_only:false; response_revision:21319; number_of_response:1; }","duration":"156.065037ms","start":"2026-07-09T00:21:08.512884Z","end":"2026-07-09T00:21:08.668949Z","steps":["trace[69346047] 'process raft request' (duration: 155.874854ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T00:22:31.066843Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19813} {"level":"info","ts":"2026-07-09T00:22:31.194055Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19813,"took":"122.223904ms","hash":249870448,"current-db-size-bytes":59224064,"current-db-size":"59 MB","current-db-size-in-use-bytes":30248960,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-07-09T00:22:31.194154Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":249870448,"revision":19813,"compact-revision":17484} {"level":"info","ts":"2026-07-09T00:25:10.356718Z","caller":"traceutil/trace.go:171","msg":"trace[628305426] linearizableReadLoop","detail":"{readStateIndex:24541; appliedIndex:24540; }","duration":"110.038955ms","start":"2026-07-09T00:25:10.246655Z","end":"2026-07-09T00:25:10.356694Z","steps":["trace[628305426] 'read index received' (duration: 109.847222ms)","trace[628305426] 'applied index is now lower than readState.Index' (duration: 190.543µs)"],"step_count":2} {"level":"warn","ts":"2026-07-09T00:25:10.356865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.183038ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/services/cert-manager-test/\" range_end:\"/registry/openstack.k-orc.cloud/services/cert-manager-test0\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-09T00:25:10.356908Z","caller":"traceutil/trace.go:171","msg":"trace[214528775] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/services/cert-manager-test/; range_end:/registry/openstack.k-orc.cloud/services/cert-manager-test0; response_count:0; response_revision:23747; }","duration":"110.248249ms","start":"2026-07-09T00:25:10.246651Z","end":"2026-07-09T00:25:10.3569Z","steps":["trace[214528775] 'agreement among raft nodes before linearized reading' (duration: 110.128857ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T00:25:10.356744Z","caller":"traceutil/trace.go:171","msg":"trace[658233383] transaction","detail":"{read_only:false; response_revision:23747; number_of_response:1; }","duration":"111.388031ms","start":"2026-07-09T00:25:10.245336Z","end":"2026-07-09T00:25:10.356724Z","steps":["trace[658233383] 'process raft request' (duration: 111.158997ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T00:27:31.079467Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":22061} {"level":"info","ts":"2026-07-09T00:27:31.189914Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":22061,"took":"104.783288ms","hash":4173013237,"current-db-size-bytes":59224064,"current-db-size":"59 MB","current-db-size-in-use-bytes":44883968,"current-db-size-in-use":"45 MB"} {"level":"info","ts":"2026-07-09T00:27:31.18998Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4173013237,"revision":22061,"compact-revision":19813} {"level":"info","ts":"2026-07-09T00:28:04.264663Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-00000000000066f1.wal"} {"level":"warn","ts":"2026-07-09T00:28:36.127627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.008335ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-09T00:28:36.127844Z","caller":"traceutil/trace.go:171","msg":"trace[160554435] transaction","detail":"{read_only:false; response_revision:25871; number_of_response:1; }","duration":"271.75817ms","start":"2026-07-09T00:28:35.856067Z","end":"2026-07-09T00:28:36.127825Z","steps":["trace[160554435] 'process raft request' (duration: 271.678349ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T00:28:36.128174Z","caller":"traceutil/trace.go:171","msg":"trace[1659919164] transaction","detail":"{read_only:false; response_revision:25870; number_of_response:1; }","duration":"272.113877ms","start":"2026-07-09T00:28:35.856049Z","end":"2026-07-09T00:28:36.128163Z","steps":["trace[1659919164] 'process raft request' (duration: 139.456059ms)","trace[1659919164] 'compare' (duration: 131.870323ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T00:28:36.151747Z","caller":"traceutil/trace.go:171","msg":"trace[1681594342] linearizableReadLoop","detail":"{readStateIndex:26723; appliedIndex:26720; }","duration":"208.332282ms","start":"2026-07-09T00:28:35.943381Z","end":"2026-07-09T00:28:36.151713Z","steps":["trace[1681594342] 'read index received' (duration: 52.14271ms)","trace[1681594342] 'applied index is now lower than readState.Index' (duration: 156.188072ms)"],"step_count":2} {"level":"warn","ts":"2026-07-09T00:28:36.151894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.493715ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-09T00:28:36.151927Z","caller":"traceutil/trace.go:171","msg":"trace[1586006832] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:25872; }","duration":"208.578967ms","start":"2026-07-09T00:28:35.943339Z","end":"2026-07-09T00:28:36.151918Z","steps":["trace[1586006832] 'agreement among raft nodes before linearized reading' (duration: 208.483876ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T00:28:36.151959Z","caller":"traceutil/trace.go:171","msg":"trace[808597489] transaction","detail":"{read_only:false; response_revision:25872; number_of_response:1; }","duration":"226.665208ms","start":"2026-07-09T00:28:35.925268Z","end":"2026-07-09T00:28:36.151933Z","steps":["trace[808597489] 'process raft request' (duration: 226.28384ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T00:28:36.290029Z","caller":"traceutil/trace.go:171","msg":"trace[207808757] linearizableReadLoop","detail":"{readStateIndex:26724; appliedIndex:26723; }","duration":"134.423222ms","start":"2026-07-09T00:28:36.155585Z","end":"2026-07-09T00:28:36.290008Z","steps":["trace[207808757] 'read index received' (duration: 122.304287ms)","trace[207808757] 'applied index is now lower than readState.Index' (duration: 12.114505ms)"],"step_count":2} {"level":"warn","ts":"2026-07-09T00:28:36.290167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.564145ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-09T00:28:36.290199Z","caller":"traceutil/trace.go:171","msg":"trace[2027092807] range","detail":"{range_begin:/registry/services/specs/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:25873; }","duration":"134.650357ms","start":"2026-07-09T00:28:36.15554Z","end":"2026-07-09T00:28:36.29019Z","steps":["trace[2027092807] 'agreement among raft nodes before linearized reading' (duration: 134.554655ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T00:28:36.290459Z","caller":"traceutil/trace.go:171","msg":"trace[266162891] transaction","detail":"{read_only:false; response_revision:25873; number_of_response:1; }","duration":"240.651338ms","start":"2026-07-09T00:28:36.049797Z","end":"2026-07-09T00:28:36.290448Z","steps":["trace[266162891] 'process raft request' (duration: 228.133306ms)","trace[266162891] 'compare' (duration: 11.87894ms)"],"step_count":2} {"level":"warn","ts":"2026-07-09T00:28:36.5894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.376032ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-09T00:28:36.589825Z","caller":"traceutil/trace.go:171","msg":"trace[2077222247] transaction","detail":"{read_only:false; response_revision:25874; number_of_response:1; }","duration":"207.873755ms","start":"2026-07-09T00:28:36.381902Z","end":"2026-07-09T00:28:36.589776Z","steps":["trace[2077222247] 'process raft request' (duration: 74.035784ms)","trace[2077222247] 'compare' (duration: 133.228298ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T00:28:36.589922Z","caller":"traceutil/trace.go:171","msg":"trace[1698080994] transaction","detail":"{read_only:false; response_revision:25875; number_of_response:1; }","duration":"206.764463ms","start":"2026-07-09T00:28:36.383134Z","end":"2026-07-09T00:28:36.589898Z","steps":["trace[1698080994] 'process raft request' (duration: 206.380966ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T00:28:36.59003Z","caller":"traceutil/trace.go:171","msg":"trace[189687501] transaction","detail":"{read_only:false; response_revision:25876; number_of_response:1; }","duration":"204.899786ms","start":"2026-07-09T00:28:36.385119Z","end":"2026-07-09T00:28:36.590019Z","steps":["trace[189687501] 'process raft request' (duration: 204.445658ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T00:28:38.016845Z","caller":"traceutil/trace.go:171","msg":"trace[965796660] transaction","detail":"{read_only:false; response_revision:25885; number_of_response:1; }","duration":"125.49449ms","start":"2026-07-09T00:28:37.891329Z","end":"2026-07-09T00:28:38.016823Z","steps":["trace[965796660] 'process raft request' (duration: 125.343047ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T00:28:38.019204Z","caller":"traceutil/trace.go:171","msg":"trace[1363368957] linearizableReadLoop","detail":"{readStateIndex:26737; appliedIndex:26735; }","duration":"110.288994ms","start":"2026-07-09T00:28:37.908887Z","end":"2026-07-09T00:28:38.019176Z","steps":["trace[1363368957] 'read index received' (duration: 107.823636ms)","trace[1363368957] 'applied index is now lower than readState.Index' (duration: 2.463428ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T00:28:38.019333Z","caller":"traceutil/trace.go:171","msg":"trace[1599078702] transaction","detail":"{read_only:false; response_revision:25886; number_of_response:1; }","duration":"127.764423ms","start":"2026-07-09T00:28:37.891556Z","end":"2026-07-09T00:28:38.01932Z","steps":["trace[1599078702] 'process raft request' (duration: 127.471008ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T00:28:38.019475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.57885ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-09T00:28:38.019516Z","caller":"traceutil/trace.go:171","msg":"trace[450663238] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:25886; }","duration":"110.678052ms","start":"2026-07-09T00:28:37.908829Z","end":"2026-07-09T00:28:38.019508Z","steps":["trace[450663238] 'agreement among raft nodes before linearized reading' (duration: 110.58598ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T00:28:43.235618Z","caller":"traceutil/trace.go:171","msg":"trace[1630386803] linearizableReadLoop","detail":"{readStateIndex:26789; appliedIndex:26788; }","duration":"323.045423ms","start":"2026-07-09T00:28:42.912553Z","end":"2026-07-09T00:28:43.235598Z","steps":["trace[1630386803] 'read index received' (duration: 322.963852ms)","trace[1630386803] 'applied index is now lower than readState.Index' (duration: 80.491µs)"],"step_count":2} {"level":"info","ts":"2026-07-09T00:28:43.235831Z","caller":"traceutil/trace.go:171","msg":"trace[1848620783] transaction","detail":"{read_only:false; response_revision:25937; number_of_response:1; }","duration":"363.218242ms","start":"2026-07-09T00:28:42.872604Z","end":"2026-07-09T00:28:43.235822Z","steps":["trace[1848620783] 'process raft request' (duration: 362.850905ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T00:28:43.235927Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T00:28:42.872583Z","time spent":"363.275512ms","remote":"127.0.0.1:44232","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":607,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-09T00:28:43.235957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.38509ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/nfd.k8s-sigs.io/nodefeaturerules/\" range_end:\"/registry/nfd.k8s-sigs.io/nodefeaturerules0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-09T00:28:43.236043Z","caller":"traceutil/trace.go:171","msg":"trace[232764847] range","detail":"{range_begin:/registry/nfd.k8s-sigs.io/nodefeaturerules/; range_end:/registry/nfd.k8s-sigs.io/nodefeaturerules0; response_count:0; response_revision:25937; }","duration":"323.528222ms","start":"2026-07-09T00:28:42.912491Z","end":"2026-07-09T00:28:43.236019Z","steps":["trace[232764847] 'agreement among raft nodes before linearized reading' (duration: 323.373339ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T00:28:43.236086Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T00:28:42.912464Z","time spent":"323.611653ms","remote":"127.0.0.1:46302","response type":"/etcdserverpb.KV/Range","request count":0,"request size":92,"response count":0,"response size":28,"request content":"key:\"/registry/nfd.k8s-sigs.io/nodefeaturerules/\" range_end:\"/registry/nfd.k8s-sigs.io/nodefeaturerules0\" count_only:true "} {"level":"warn","ts":"2026-07-09T00:28:43.498113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.098768ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-09T00:28:43.498259Z","caller":"traceutil/trace.go:171","msg":"trace[352810369] linearizableReadLoop","detail":"{readStateIndex:26790; appliedIndex:26789; }","duration":"262.521892ms","start":"2026-07-09T00:28:43.235677Z","end":"2026-07-09T00:28:43.498199Z","steps":["trace[352810369] 'read index received' (duration: 83.15996ms)","trace[352810369] 'applied index is now lower than readState.Index' (duration: 179.360352ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T00:28:43.498531Z","caller":"traceutil/trace.go:171","msg":"trace[1736933010] transaction","detail":"{read_only:false; response_revision:25938; number_of_response:1; }","duration":"380.67791ms","start":"2026-07-09T00:28:43.11782Z","end":"2026-07-09T00:28:43.498498Z","steps":["trace[1736933010] 'process raft request' (duration: 201.101054ms)","trace[1736933010] 'compare' (duration: 178.630958ms)"],"step_count":2} {"level":"warn","ts":"2026-07-09T00:28:43.498588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"498.398778ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"warn","ts":"2026-07-09T00:28:43.49856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"418.402219ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-09T00:28:43.498631Z","caller":"traceutil/trace.go:171","msg":"trace[488926608] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:25938; }","duration":"498.479719ms","start":"2026-07-09T00:28:43.000139Z","end":"2026-07-09T00:28:43.498619Z","steps":["trace[488926608] 'agreement among raft nodes before linearized reading' (duration: 498.317396ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T00:28:43.498659Z","caller":"traceutil/trace.go:171","msg":"trace[78302280] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:25938; }","duration":"418.559822ms","start":"2026-07-09T00:28:43.080073Z","end":"2026-07-09T00:28:43.498632Z","steps":["trace[78302280] 'agreement among raft nodes before linearized reading' (duration: 418.366889ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T00:28:43.498703Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T00:28:43.117798Z","time spent":"380.812162ms","remote":"127.0.0.1:44232","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-09T00:28:43.49871Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T00:28:43.08005Z","time spent":"418.650014ms","remote":"127.0.0.1:35426","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true "} {"level":"warn","ts":"2026-07-09T00:28:43.498708Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T00:28:43.00012Z","time spent":"498.574262ms","remote":"127.0.0.1:44156","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":90,"response size":30,"request content":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true "} {"level":"warn","ts":"2026-07-09T00:28:43.498762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.152131ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-09T00:28:43.49886Z","caller":"traceutil/trace.go:171","msg":"trace[990276886] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:25938; }","duration":"175.295544ms","start":"2026-07-09T00:28:43.32354Z","end":"2026-07-09T00:28:43.498835Z","steps":["trace[990276886] 'agreement among raft nodes before linearized reading' (duration: 175.138261ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T00:28:43.824747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.172139ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-09T00:28:43.825075Z","caller":"traceutil/trace.go:171","msg":"trace[1883794938] transaction","detail":"{read_only:false; response_revision:25939; number_of_response:1; }","duration":"321.723098ms","start":"2026-07-09T00:28:43.503332Z","end":"2026-07-09T00:28:43.825056Z","steps":["trace[1883794938] 'process raft request' (duration: 128.168861ms)","trace[1883794938] 'compare' (duration: 193.042267ms)"],"step_count":2} {"level":"warn","ts":"2026-07-09T00:28:43.82513Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T00:28:43.503312Z","time spent":"321.795159ms","remote":"127.0.0.1:44232","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-09T00:28:43.825437Z","caller":"traceutil/trace.go:171","msg":"trace[1432616159] transaction","detail":"{read_only:false; response_revision:25940; number_of_response:1; }","duration":"149.390713ms","start":"2026-07-09T00:28:43.676041Z","end":"2026-07-09T00:28:43.825432Z","steps":["trace[1432616159] 'process raft request' (duration: 148.954403ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T00:28:44.409407Z","caller":"traceutil/trace.go:171","msg":"trace[2052537300] linearizableReadLoop","detail":"{readStateIndex:26794; appliedIndex:26792; }","duration":"286.927064ms","start":"2026-07-09T00:28:44.12238Z","end":"2026-07-09T00:28:44.409307Z","steps":["trace[2052537300] 'read index received' (duration: 16.840326ms)","trace[2052537300] 'applied index is now lower than readState.Index' (duration: 270.085728ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T00:28:44.409421Z","caller":"traceutil/trace.go:171","msg":"trace[1387773777] transaction","detail":"{read_only:false; response_revision:25942; number_of_response:1; }","duration":"297.665602ms","start":"2026-07-09T00:28:44.11171Z","end":"2026-07-09T00:28:44.409376Z","steps":["trace[1387773777] 'process raft request' (duration: 297.397387ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T00:28:44.409669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.27379ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.177\" ","response":"range_response_count:1 size:140"} {"level":"info","ts":"2026-07-09T00:28:44.409719Z","caller":"traceutil/trace.go:171","msg":"trace[600690696] range","detail":"{range_begin:/registry/masterleases/199.204.45.177; range_end:; response_count:1; response_revision:25942; }","duration":"287.356512ms","start":"2026-07-09T00:28:44.122341Z","end":"2026-07-09T00:28:44.409697Z","steps":["trace[600690696] 'agreement among raft nodes before linearized reading' (duration: 287.161078ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T00:28:44.419626Z","caller":"traceutil/trace.go:171","msg":"trace[1813089895] transaction","detail":"{read_only:false; response_revision:25943; number_of_response:1; }","duration":"173.546839ms","start":"2026-07-09T00:28:44.246056Z","end":"2026-07-09T00:28:44.419602Z","steps":["trace[1813089895] 'process raft request' (duration: 173.364976ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T00:28:44.419681Z","caller":"traceutil/trace.go:171","msg":"trace[562184491] transaction","detail":"{read_only:false; response_revision:25944; number_of_response:1; }","duration":"106.670835ms","start":"2026-07-09T00:28:44.312978Z","end":"2026-07-09T00:28:44.419648Z","steps":["trace[562184491] 'process raft request' (duration: 106.555543ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T00:28:44.419736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.1434ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-07-09T00:28:44.419793Z","caller":"traceutil/trace.go:171","msg":"trace[397585749] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25944; }","duration":"130.245852ms","start":"2026-07-09T00:28:44.289535Z","end":"2026-07-09T00:28:44.419781Z","steps":["trace[397585749] 'agreement among raft nodes before linearized reading' (duration: 130.062708ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T00:28:44.419856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.540682ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-07-09T00:28:44.419975Z","caller":"traceutil/trace.go:171","msg":"trace[943019437] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25944; }","duration":"124.701085ms","start":"2026-07-09T00:28:44.295255Z","end":"2026-07-09T00:28:44.419956Z","steps":["trace[943019437] 'agreement among raft nodes before linearized reading' (duration: 124.45628ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T00:28:44.994868Z","caller":"traceutil/trace.go:171","msg":"trace[1092156539] linearizableReadLoop","detail":"{readStateIndex:26803; appliedIndex:26800; }","duration":"370.094624ms","start":"2026-07-09T00:28:44.624742Z","end":"2026-07-09T00:28:44.994837Z","steps":["trace[1092156539] 'read index received' (duration: 90.41198ms)","trace[1092156539] 'applied index is now lower than readState.Index' (duration: 279.681244ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T00:28:44.995158Z","caller":"traceutil/trace.go:171","msg":"trace[374800537] transaction","detail":"{read_only:false; response_revision:25949; number_of_response:1; }","duration":"373.253865ms","start":"2026-07-09T00:28:44.621891Z","end":"2026-07-09T00:28:44.995145Z","steps":["trace[374800537] 'process raft request' (duration: 372.722795ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T00:28:44.995273Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T00:28:44.621853Z","time spent":"373.334897ms","remote":"127.0.0.1:44232","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-09T00:28:44.99547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"370.727226ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectrealms/\" range_end:\"/registry/ceph.rook.io/cephobjectrealms0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-09T00:28:44.995512Z","caller":"traceutil/trace.go:171","msg":"trace[1798210063] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectrealms/; range_end:/registry/ceph.rook.io/cephobjectrealms0; response_count:0; response_revision:25950; }","duration":"370.805367ms","start":"2026-07-09T00:28:44.624692Z","end":"2026-07-09T00:28:44.995498Z","steps":["trace[1798210063] 'agreement among raft nodes before linearized reading' (duration: 370.723446ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T00:28:44.995546Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T00:28:44.624671Z","time spent":"370.867738ms","remote":"127.0.0.1:45626","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":0,"response size":28,"request content":"key:\"/registry/ceph.rook.io/cephobjectrealms/\" range_end:\"/registry/ceph.rook.io/cephobjectrealms0\" count_only:true "} {"level":"info","ts":"2026-07-09T00:28:44.995766Z","caller":"traceutil/trace.go:171","msg":"trace[500726894] transaction","detail":"{read_only:false; response_revision:25950; number_of_response:1; }","duration":"372.720845ms","start":"2026-07-09T00:28:44.623016Z","end":"2026-07-09T00:28:44.995737Z","steps":["trace[500726894] 'process raft request' (duration: 371.768797ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T00:28:44.995828Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T00:28:44.62299Z","time spent":"372.799856ms","remote":"127.0.0.1:44232","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-09T00:28:45.215159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.345206ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-09T00:28:45.215243Z","caller":"traceutil/trace.go:171","msg":"trace[1850544670] linearizableReadLoop","detail":"{readStateIndex:26804; appliedIndex:26803; }","duration":"220.283494ms","start":"2026-07-09T00:28:44.994945Z","end":"2026-07-09T00:28:45.215229Z","steps":["trace[1850544670] 'read index received' (duration: 15.765186ms)","trace[1850544670] 'applied index is now lower than readState.Index' (duration: 204.516958ms)"],"step_count":2} {"level":"warn","ts":"2026-07-09T00:28:45.215413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"524.140306ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2083"} {"level":"info","ts":"2026-07-09T00:28:45.215446Z","caller":"traceutil/trace.go:171","msg":"trace[462345411] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:25951; }","duration":"524.201247ms","start":"2026-07-09T00:28:44.69123Z","end":"2026-07-09T00:28:45.215431Z","steps":["trace[462345411] 'agreement among raft nodes before linearized reading' (duration: 524.040164ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T00:28:45.215477Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T00:28:44.691212Z","time spent":"524.256938ms","remote":"127.0.0.1:44116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":139,"response count":1,"response size":2105,"request content":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" "} {"level":"info","ts":"2026-07-09T00:28:45.215756Z","caller":"traceutil/trace.go:171","msg":"trace[939971117] transaction","detail":"{read_only:false; response_revision:25951; number_of_response:1; }","duration":"483.385798ms","start":"2026-07-09T00:28:44.732354Z","end":"2026-07-09T00:28:45.21574Z","steps":["trace[939971117] 'process raft request' (duration: 278.39662ms)","trace[939971117] 'compare' (duration: 203.170792ms)"],"step_count":2} {"level":"warn","ts":"2026-07-09T00:28:45.215817Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T00:28:44.732328Z","time spent":"483.455299ms","remote":"127.0.0.1:44232","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-09T00:28:45.216009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"512.039632ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-07-09T00:28:45.216039Z","caller":"traceutil/trace.go:171","msg":"trace[976425627] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/; range_end:/registry/apiregistration.k8s.io/apiservices0; response_count:0; response_revision:25951; }","duration":"512.099384ms","start":"2026-07-09T00:28:44.703929Z","end":"2026-07-09T00:28:45.216028Z","steps":["trace[976425627] 'agreement among raft nodes before linearized reading' (duration: 512.007392ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T00:28:45.216073Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T00:28:44.703912Z","time spent":"512.151804ms","remote":"127.0.0.1:44490","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":60,"response size":30,"request content":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true "} {"level":"info","ts":"2026-07-09T00:28:45.50954Z","caller":"traceutil/trace.go:171","msg":"trace[582843579] linearizableReadLoop","detail":"{readStateIndex:26805; appliedIndex:26804; }","duration":"229.120435ms","start":"2026-07-09T00:28:45.280373Z","end":"2026-07-09T00:28:45.509493Z","steps":["trace[582843579] 'read index received' (duration: 187.632352ms)","trace[582843579] 'applied index is now lower than readState.Index' (duration: 41.487283ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T00:28:45.509553Z","caller":"traceutil/trace.go:171","msg":"trace[352687441] transaction","detail":"{read_only:false; response_revision:25952; number_of_response:1; }","duration":"268.182892ms","start":"2026-07-09T00:28:45.241338Z","end":"2026-07-09T00:28:45.509521Z","steps":["trace[352687441] 'process raft request' (duration: 226.689409ms)","trace[352687441] 'compare' (duration: 41.33355ms)"],"step_count":2} {"level":"warn","ts":"2026-07-09T00:28:45.509675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.290858ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates/\" range_end:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-09T00:28:45.509706Z","caller":"traceutil/trace.go:171","msg":"trace[2101120685] range","detail":"{range_begin:/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates/; range_end:/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates0; response_count:0; response_revision:25952; }","duration":"229.357499ms","start":"2026-07-09T00:28:45.280338Z","end":"2026-07-09T00:28:45.509696Z","steps":["trace[2101120685] 'agreement among raft nodes before linearized reading' (duration: 229.241657ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T00:28:45.837918Z","caller":"traceutil/trace.go:171","msg":"trace[1273111677] linearizableReadLoop","detail":"{readStateIndex:26806; appliedIndex:26805; }","duration":"328.303656ms","start":"2026-07-09T00:28:45.509591Z","end":"2026-07-09T00:28:45.837895Z","steps":["trace[1273111677] 'read index received' (duration: 314.449317ms)","trace[1273111677] 'applied index is now lower than readState.Index' (duration: 13.853189ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T00:28:45.838024Z","caller":"traceutil/trace.go:171","msg":"trace[639225886] transaction","detail":"{read_only:false; response_revision:25953; number_of_response:1; }","duration":"332.62264ms","start":"2026-07-09T00:28:45.505376Z","end":"2026-07-09T00:28:45.837999Z","steps":["trace[639225886] 'process raft request' (duration: 318.68195ms)","trace[639225886] 'compare' (duration: 13.387869ms)"],"step_count":2} {"level":"warn","ts":"2026-07-09T00:28:45.838138Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T00:28:45.505349Z","time spent":"332.722371ms","remote":"127.0.0.1:44232","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-09T00:28:45.838126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"553.422762ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/images/\" range_end:\"/registry/openstack.k-orc.cloud/images0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-09T00:28:45.838208Z","caller":"traceutil/trace.go:171","msg":"trace[67110941] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/images/; range_end:/registry/openstack.k-orc.cloud/images0; response_count:0; response_revision:25953; }","duration":"553.547666ms","start":"2026-07-09T00:28:45.28464Z","end":"2026-07-09T00:28:45.838188Z","steps":["trace[67110941] 'agreement among raft nodes before linearized reading' (duration: 553.378563ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T00:28:45.83826Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T00:28:45.28463Z","time spent":"553.618717ms","remote":"127.0.0.1:49000","response type":"/etcdserverpb.KV/Range","request count":0,"request size":84,"response count":0,"response size":28,"request content":"key:\"/registry/openstack.k-orc.cloud/images/\" range_end:\"/registry/openstack.k-orc.cloud/images0\" count_only:true "} {"level":"warn","ts":"2026-07-09T00:28:45.862762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.898255ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/clusters/\" range_end:\"/registry/cluster.x-k8s.io/clusters0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-09T00:28:45.862897Z","caller":"traceutil/trace.go:171","msg":"trace[1273921909] range","detail":"{range_begin:/registry/cluster.x-k8s.io/clusters/; range_end:/registry/cluster.x-k8s.io/clusters0; response_count:0; response_revision:25954; }","duration":"316.051629ms","start":"2026-07-09T00:28:45.546797Z","end":"2026-07-09T00:28:45.862848Z","steps":["trace[1273921909] 'agreement among raft nodes before linearized reading' (duration: 304.565266ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T00:28:45.862955Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T00:28:45.546781Z","time spent":"316.16146ms","remote":"127.0.0.1:59602","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":28,"request content":"key:\"/registry/cluster.x-k8s.io/clusters/\" range_end:\"/registry/cluster.x-k8s.io/clusters0\" count_only:true "} {"level":"warn","ts":"2026-07-09T00:28:45.862778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.498647ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/schemareplications/\" range_end:\"/registry/rabbitmq.com/schemareplications0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-09T00:28:45.863259Z","caller":"traceutil/trace.go:171","msg":"trace[234709652] range","detail":"{range_begin:/registry/rabbitmq.com/schemareplications/; range_end:/registry/rabbitmq.com/schemareplications0; response_count:0; response_revision:25954; }","duration":"299.996827ms","start":"2026-07-09T00:28:45.563229Z","end":"2026-07-09T00:28:45.863226Z","steps":["trace[234709652] 'agreement among raft nodes before linearized reading' (duration: 288.202699ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T00:28:45.863339Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T00:28:45.563195Z","time spent":"300.109599ms","remote":"127.0.0.1:50496","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":28,"request content":"key:\"/registry/rabbitmq.com/schemareplications/\" range_end:\"/registry/rabbitmq.com/schemareplications0\" count_only:true "} {"level":"info","ts":"2026-07-09T00:28:53.126642Z","caller":"traceutil/trace.go:171","msg":"trace[1115666925] linearizableReadLoop","detail":"{readStateIndex:26875; appliedIndex:26873; }","duration":"103.617156ms","start":"2026-07-09T00:28:53.023Z","end":"2026-07-09T00:28:53.126617Z","steps":["trace[1115666925] 'read index received' (duration: 88.718007ms)","trace[1115666925] 'applied index is now lower than readState.Index' (duration: 14.897979ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T00:28:53.126732Z","caller":"traceutil/trace.go:171","msg":"trace[1419151311] transaction","detail":"{read_only:false; response_revision:26021; number_of_response:1; }","duration":"107.436999ms","start":"2026-07-09T00:28:53.019267Z","end":"2026-07-09T00:28:53.126704Z","steps":["trace[1419151311] 'process raft request' (duration: 107.221805ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T00:28:53.126783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.759838ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/machinesets/\" range_end:\"/registry/cluster.x-k8s.io/machinesets0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-09T00:28:53.12683Z","caller":"traceutil/trace.go:171","msg":"trace[681066403] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machinesets/; range_end:/registry/cluster.x-k8s.io/machinesets0; response_count:0; response_revision:26021; }","duration":"103.88161ms","start":"2026-07-09T00:28:53.022933Z","end":"2026-07-09T00:28:53.126815Z","steps":["trace[681066403] 'agreement among raft nodes before linearized reading' (duration: 103.783768ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T00:28:54.000737Z","caller":"traceutil/trace.go:171","msg":"trace[2091801586] transaction","detail":"{read_only:false; response_revision:26023; number_of_response:1; }","duration":"137.9419ms","start":"2026-07-09T00:28:53.862766Z","end":"2026-07-09T00:28:54.000708Z","steps":["trace[2091801586] 'process raft request' (duration: 137.721126ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T00:28:54.298239Z","caller":"traceutil/trace.go:171","msg":"trace[392416323] linearizableReadLoop","detail":"{readStateIndex:26878; appliedIndex:26876; }","duration":"387.701014ms","start":"2026-07-09T00:28:53.910489Z","end":"2026-07-09T00:28:54.29819Z","steps":["trace[392416323] 'read index received' (duration: 90.063833ms)","trace[392416323] 'applied index is now lower than readState.Index' (duration: 297.635431ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T00:28:54.298696Z","caller":"traceutil/trace.go:171","msg":"trace[1857631121] transaction","detail":"{read_only:false; response_revision:26024; number_of_response:1; }","duration":"404.810076ms","start":"2026-07-09T00:28:53.893848Z","end":"2026-07-09T00:28:54.298658Z","steps":["trace[1857631121] 'process raft request' (duration: 404.076702ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T00:28:54.298779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.256195ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-07-09T00:28:54.298852Z","caller":"traceutil/trace.go:171","msg":"trace[2110997419] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26024; }","duration":"388.390528ms","start":"2026-07-09T00:28:53.910444Z","end":"2026-07-09T00:28:54.298834Z","steps":["trace[2110997419] 'agreement among raft nodes before linearized reading' (duration: 388.096082ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T00:28:54.298878Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T00:28:53.893819Z","time spent":"404.979599ms","remote":"127.0.0.1:44232","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-09T00:28:54.298893Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T00:28:53.91043Z","time spent":"388.454999ms","remote":"127.0.0.1:44232","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-09T00:28:54.298946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.477447ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.177\" ","response":"range_response_count:1 size:140"} {"level":"info","ts":"2026-07-09T00:28:54.299056Z","caller":"traceutil/trace.go:171","msg":"trace[1965607819] range","detail":"{range_begin:/registry/masterleases/199.204.45.177; range_end:; response_count:1; response_revision:26024; }","duration":"176.615639ms","start":"2026-07-09T00:28:54.122396Z","end":"2026-07-09T00:28:54.299011Z","steps":["trace[1965607819] 'agreement among raft nodes before linearized reading' (duration: 176.340004ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T00:28:54.299163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.61838ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-07-09T00:28:54.299272Z","caller":"traceutil/trace.go:171","msg":"trace[1166209600] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26024; }","duration":"112.818663ms","start":"2026-07-09T00:28:54.186432Z","end":"2026-07-09T00:28:54.299251Z","steps":["trace[1166209600] 'agreement among raft nodes before linearized reading' (duration: 112.245183ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T00:28:54.30005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.289204ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-09T00:28:54.300181Z","caller":"traceutil/trace.go:171","msg":"trace[1332675325] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26024; }","duration":"284.684101ms","start":"2026-07-09T00:28:54.015433Z","end":"2026-07-09T00:28:54.300117Z","steps":["trace[1332675325] 'agreement among raft nodes before linearized reading' (duration: 283.233242ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T00:28:54.453157Z","caller":"traceutil/trace.go:171","msg":"trace[1782736628] transaction","detail":"{read_only:false; response_revision:26027; number_of_response:1; }","duration":"142.59742ms","start":"2026-07-09T00:28:54.310481Z","end":"2026-07-09T00:28:54.453078Z","steps":["trace[1782736628] 'process raft request' (duration: 137.734697ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T00:28:54.620296Z","caller":"traceutil/trace.go:171","msg":"trace[973083129] linearizableReadLoop","detail":"{readStateIndex:26884; appliedIndex:26882; }","duration":"165.424762ms","start":"2026-07-09T00:28:54.454847Z","end":"2026-07-09T00:28:54.620272Z","steps":["trace[973083129] 'read index received' (duration: 13.249966ms)","trace[973083129] 'applied index is now lower than readState.Index' (duration: 152.173036ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T00:28:54.620414Z","caller":"traceutil/trace.go:171","msg":"trace[527291827] transaction","detail":"{read_only:false; response_revision:26030; number_of_response:1; }","duration":"164.28706ms","start":"2026-07-09T00:28:54.456065Z","end":"2026-07-09T00:28:54.620352Z","steps":["trace[527291827] 'process raft request' (duration: 163.899343ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T00:28:54.620602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.19431ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-07-09T00:28:54.620685Z","caller":"traceutil/trace.go:171","msg":"trace[2120984377] transaction","detail":"{read_only:false; response_revision:26029; number_of_response:1; }","duration":"167.419761ms","start":"2026-07-09T00:28:54.452752Z","end":"2026-07-09T00:28:54.620171Z","steps":["trace[2120984377] 'process raft request' (duration: 167.054294ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T00:28:54.620696Z","caller":"traceutil/trace.go:171","msg":"trace[1600855985] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26030; }","duration":"144.341174ms","start":"2026-07-09T00:28:54.476336Z","end":"2026-07-09T00:28:54.620677Z","steps":["trace[1600855985] 'agreement among raft nodes before linearized reading' (duration: 144.081089ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T00:28:54.620623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.214311ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-07-09T00:28:54.620845Z","caller":"traceutil/trace.go:171","msg":"trace[1373611139] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26030; }","duration":"144.456746ms","start":"2026-07-09T00:28:54.476356Z","end":"2026-07-09T00:28:54.620812Z","steps":["trace[1373611139] 'agreement among raft nodes before linearized reading' (duration: 144.059489ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T00:28:54.62096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.116746ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:423"} {"level":"info","ts":"2026-07-09T00:28:54.62102Z","caller":"traceutil/trace.go:171","msg":"trace[280588542] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:26030; }","duration":"166.228268ms","start":"2026-07-09T00:28:54.454775Z","end":"2026-07-09T00:28:54.621004Z","steps":["trace[280588542] 'agreement among raft nodes before linearized reading' (duration: 165.576755ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T00:28:55.354675Z","caller":"traceutil/trace.go:171","msg":"trace[930376963] transaction","detail":"{read_only:false; response_revision:26036; number_of_response:1; }","duration":"222.470816ms","start":"2026-07-09T00:28:55.13216Z","end":"2026-07-09T00:28:55.354631Z","steps":["trace[930376963] 'process raft request' (duration: 211.82444ms)","trace[930376963] 'compare' (duration: 10.441532ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T00:28:55.365923Z","caller":"traceutil/trace.go:171","msg":"trace[262495337] transaction","detail":"{read_only:false; response_revision:26037; number_of_response:1; }","duration":"173.623321ms","start":"2026-07-09T00:28:55.192268Z","end":"2026-07-09T00:28:55.365892Z","steps":["trace[262495337] 'process raft request' (duration: 173.310685ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T00:28:55.686806Z","caller":"traceutil/trace.go:171","msg":"trace[980309061] transaction","detail":"{read_only:false; response_revision:26038; number_of_response:1; }","duration":"137.235867ms","start":"2026-07-09T00:28:55.549538Z","end":"2026-07-09T00:28:55.686774Z","steps":["trace[980309061] 'process raft request' (duration: 136.949601ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T00:28:55.81584Z","caller":"traceutil/trace.go:171","msg":"trace[1556984230] transaction","detail":"{read_only:false; response_revision:26039; number_of_response:1; }","duration":"254.371854ms","start":"2026-07-09T00:28:55.561419Z","end":"2026-07-09T00:28:55.815791Z","steps":["trace[1556984230] 'process raft request' (duration: 194.684758ms)","trace[1556984230] 'compare' (duration: 59.428451ms)"],"step_count":2} {"level":"warn","ts":"2026-07-09T00:28:55.81609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.282201ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-07-09T00:28:55.816178Z","caller":"traceutil/trace.go:171","msg":"trace[1114755776] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:26039; }","duration":"177.441094ms","start":"2026-07-09T00:28:55.638714Z","end":"2026-07-09T00:28:55.816156Z","steps":["trace[1114755776] 'agreement among raft nodes before linearized reading' (duration: 177.278441ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T00:28:55.81622Z","caller":"traceutil/trace.go:171","msg":"trace[215025789] linearizableReadLoop","detail":"{readStateIndex:26894; appliedIndex:26892; }","duration":"177.407114ms","start":"2026-07-09T00:28:55.638776Z","end":"2026-07-09T00:28:55.816184Z","steps":["trace[215025789] 'read index received' (duration: 47.679263ms)","trace[215025789] 'applied index is now lower than readState.Index' (duration: 129.725741ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T00:28:56.555908Z","caller":"traceutil/trace.go:171","msg":"trace[635877342] linearizableReadLoop","detail":"{readStateIndex:26896; appliedIndex:26895; }","duration":"228.904082ms","start":"2026-07-09T00:28:56.326985Z","end":"2026-07-09T00:28:56.555889Z","steps":["trace[635877342] 'read index received' (duration: 228.78837ms)","trace[635877342] 'applied index is now lower than readState.Index' (duration: 114.592µs)"],"step_count":2} {"level":"info","ts":"2026-07-09T00:28:56.55598Z","caller":"traceutil/trace.go:171","msg":"trace[309850695] transaction","detail":"{read_only:false; response_revision:26041; number_of_response:1; }","duration":"250.968209ms","start":"2026-07-09T00:28:56.30498Z","end":"2026-07-09T00:28:56.555948Z","steps":["trace[309850695] 'process raft request' (duration: 250.761835ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T00:28:56.556132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.131296ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-07-09T00:28:56.556156Z","caller":"traceutil/trace.go:171","msg":"trace[1042579722] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26041; }","duration":"229.233268ms","start":"2026-07-09T00:28:56.326916Z","end":"2026-07-09T00:28:56.55615Z","steps":["trace[1042579722] 'agreement among raft nodes before linearized reading' (duration: 229.087395ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T00:28:56.561213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.434688ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-07-09T00:28:56.561283Z","caller":"traceutil/trace.go:171","msg":"trace[226418290] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26043; }","duration":"233.536ms","start":"2026-07-09T00:28:56.327732Z","end":"2026-07-09T00:28:56.561268Z","steps":["trace[226418290] 'agreement among raft nodes before linearized reading' (duration: 233.340766ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T00:29:00.103449Z","caller":"traceutil/trace.go:171","msg":"trace[529781727] transaction","detail":"{read_only:false; response_revision:26075; number_of_response:1; }","duration":"269.499057ms","start":"2026-07-09T00:28:59.833918Z","end":"2026-07-09T00:29:00.103417Z","steps":["trace[529781727] 'process raft request' (duration: 269.267573ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T00:29:00.373033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.626319ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-09T00:29:00.373174Z","caller":"traceutil/trace.go:171","msg":"trace[1159458396] transaction","detail":"{read_only:false; response_revision:26076; number_of_response:1; }","duration":"315.6034ms","start":"2026-07-09T00:29:00.057543Z","end":"2026-07-09T00:29:00.373146Z","steps":["trace[1159458396] 'process raft request' (duration: 122.705636ms)","trace[1159458396] 'compare' (duration: 191.371864ms)"],"step_count":2} {"level":"warn","ts":"2026-07-09T00:29:00.373245Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T00:29:00.057517Z","time spent":"315.698041ms","remote":"127.0.0.1:44232","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-09T00:29:00.780469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.176108ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:9"} {"level":"info","ts":"2026-07-09T00:29:00.780555Z","caller":"traceutil/trace.go:171","msg":"trace[1141685275] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:26076; }","duration":"243.3184ms","start":"2026-07-09T00:29:00.537218Z","end":"2026-07-09T00:29:00.780536Z","steps":["trace[1141685275] 'count revisions from in-memory index tree' (duration: 243.077856ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T00:29:01.074923Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5605186326048371843,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-09T00:29:01.105581Z","caller":"traceutil/trace.go:171","msg":"trace[762059236] transaction","detail":"{read_only:false; response_revision:26077; number_of_response:1; }","duration":"534.341514ms","start":"2026-07-09T00:29:00.571203Z","end":"2026-07-09T00:29:01.105544Z","steps":["trace[762059236] 'process raft request' (duration: 534.085449ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T00:29:01.105856Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T00:29:00.571153Z","time spent":"534.564688ms","remote":"127.0.0.1:44232","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-09T00:29:01.262264Z","caller":"traceutil/trace.go:171","msg":"trace[1372083324] transaction","detail":"{read_only:false; response_revision:26078; number_of_response:1; }","duration":"686.713913ms","start":"2026-07-09T00:29:00.575501Z","end":"2026-07-09T00:29:01.262215Z","steps":["trace[1372083324] 'process raft request' (duration: 684.618892ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T00:29:01.262351Z","caller":"traceutil/trace.go:171","msg":"trace[261411251] linearizableReadLoop","detail":"{readStateIndex:26936; appliedIndex:26932; }","duration":"688.005118ms","start":"2026-07-09T00:29:00.574297Z","end":"2026-07-09T00:29:01.262302Z","steps":["trace[261411251] 'read index received' (duration: 531.000109ms)","trace[261411251] 'applied index is now lower than readState.Index' (duration: 157.003509ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T00:29:01.262365Z","caller":"traceutil/trace.go:171","msg":"trace[607612352] transaction","detail":"{read_only:false; response_revision:26079; number_of_response:1; }","duration":"621.736476ms","start":"2026-07-09T00:29:00.640592Z","end":"2026-07-09T00:29:01.262328Z","steps":["trace[607612352] 'process raft request' (duration: 621.544242ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T00:29:01.262434Z","caller":"traceutil/trace.go:171","msg":"trace[414391453] transaction","detail":"{read_only:false; response_revision:26080; number_of_response:1; }","duration":"427.409444ms","start":"2026-07-09T00:29:00.834981Z","end":"2026-07-09T00:29:01.26239Z","steps":["trace[414391453] 'process raft request' (duration: 427.265941ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T00:29:01.262495Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T00:29:00.575473Z","time spent":"686.896407ms","remote":"127.0.0.1:44232","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-09T00:29:01.26258Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T00:29:00.640569Z","time spent":"621.874598ms","remote":"127.0.0.1:44232","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-09T00:29:01.262632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"688.315774ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-07-09T00:29:01.262671Z","caller":"traceutil/trace.go:171","msg":"trace[1998238471] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26080; }","duration":"688.423286ms","start":"2026-07-09T00:29:00.574235Z","end":"2026-07-09T00:29:01.262659Z","steps":["trace[1998238471] 'agreement among raft nodes before linearized reading' (duration: 688.217432ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T00:29:01.262649Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T00:29:00.834943Z","time spent":"427.587898ms","remote":"127.0.0.1:44232","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":498,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-09T00:29:01.262707Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T00:29:00.574212Z","time spent":"688.486688ms","remote":"127.0.0.1:44232","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-09T00:29:01.263222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"594.58303ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-07-09T00:29:01.263256Z","caller":"traceutil/trace.go:171","msg":"trace[921785426] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26081; }","duration":"594.62967ms","start":"2026-07-09T00:29:00.668616Z","end":"2026-07-09T00:29:01.263245Z","steps":["trace[921785426] 'agreement among raft nodes before linearized reading' (duration: 594.515268ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T00:29:01.263291Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T00:29:00.668608Z","time spent":"594.670211ms","remote":"127.0.0.1:44232","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-07-09T00:29:01.263318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"685.623151ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-07-09T00:29:01.26339Z","caller":"traceutil/trace.go:171","msg":"trace[1297873240] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26081; }","duration":"685.724034ms","start":"2026-07-09T00:29:00.57765Z","end":"2026-07-09T00:29:01.263374Z","steps":["trace[1297873240] 'agreement among raft nodes before linearized reading' (duration: 685.469539ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T00:29:01.26348Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T00:29:00.577638Z","time spent":"685.796855ms","remote":"127.0.0.1:44232","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-09T00:29:01.263664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.554614ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-09T00:29:01.263703Z","caller":"traceutil/trace.go:171","msg":"trace[1632988217] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26081; }","duration":"246.639986ms","start":"2026-07-09T00:29:01.017052Z","end":"2026-07-09T00:29:01.263692Z","steps":["trace[1632988217] 'agreement among raft nodes before linearized reading' (duration: 246.571684ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T00:29:01.263807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"624.962438ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/magnum-conductor-0.18c077901987e24e\" ","response":"range_response_count:1 size:869"} {"level":"info","ts":"2026-07-09T00:29:01.263908Z","caller":"traceutil/trace.go:171","msg":"trace[827343757] range","detail":"{range_begin:/registry/events/openstack/magnum-conductor-0.18c077901987e24e; range_end:; response_count:1; response_revision:26081; }","duration":"625.105911ms","start":"2026-07-09T00:29:00.638776Z","end":"2026-07-09T00:29:01.263882Z","steps":["trace[827343757] 'agreement among raft nodes before linearized reading' (duration: 624.827105ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T00:29:01.263954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"538.620518ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/operatorpolicies/\" range_end:\"/registry/rabbitmq.com/operatorpolicies0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-09T00:29:01.26421Z","caller":"traceutil/trace.go:171","msg":"trace[1181586844] range","detail":"{range_begin:/registry/rabbitmq.com/operatorpolicies/; range_end:/registry/rabbitmq.com/operatorpolicies0; response_count:0; response_revision:26081; }","duration":"538.910422ms","start":"2026-07-09T00:29:00.725279Z","end":"2026-07-09T00:29:01.264189Z","steps":["trace[1181586844] 'agreement among raft nodes before linearized reading' (duration: 538.626587ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T00:29:01.26422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"596.63935ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-07-09T00:29:01.264148Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T00:29:00.638757Z","time spent":"625.195703ms","remote":"127.0.0.1:44036","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":891,"request content":"key:\"/registry/events/openstack/magnum-conductor-0.18c077901987e24e\" "} {"level":"info","ts":"2026-07-09T00:29:01.264261Z","caller":"traceutil/trace.go:171","msg":"trace[1802067382] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26081; }","duration":"596.718502ms","start":"2026-07-09T00:29:00.667533Z","end":"2026-07-09T00:29:01.264252Z","steps":["trace[1802067382] 'agreement among raft nodes before linearized reading' (duration: 596.61336ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T00:29:01.264268Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T00:29:00.725256Z","time spent":"538.995765ms","remote":"127.0.0.1:50662","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":0,"response size":28,"request content":"key:\"/registry/rabbitmq.com/operatorpolicies/\" range_end:\"/registry/rabbitmq.com/operatorpolicies0\" count_only:true "} {"level":"warn","ts":"2026-07-09T00:29:01.264283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"613.146399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"warn","ts":"2026-07-09T00:29:01.2643Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T00:29:00.667516Z","time spent":"596.775912ms","remote":"127.0.0.1:44232","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-07-09T00:29:01.264322Z","caller":"traceutil/trace.go:171","msg":"trace[2062498062] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26081; }","duration":"613.211601ms","start":"2026-07-09T00:29:00.6511Z","end":"2026-07-09T00:29:01.264312Z","steps":["trace[2062498062] 'agreement among raft nodes before linearized reading' (duration: 613.057098ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T00:29:01.264351Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T00:29:00.651091Z","time spent":"613.254911ms","remote":"127.0.0.1:44232","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":"warn","ts":"2026-07-09T00:29:01.263844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"642.397876ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/magnum-conductor-0\" ","response":"range_response_count:1 size:10441"} {"level":"info","ts":"2026-07-09T00:29:01.264404Z","caller":"traceutil/trace.go:171","msg":"trace[1234496821] range","detail":"{range_begin:/registry/pods/openstack/magnum-conductor-0; range_end:; response_count:1; response_revision:26081; }","duration":"642.960217ms","start":"2026-07-09T00:29:00.621429Z","end":"2026-07-09T00:29:01.264389Z","steps":["trace[1234496821] 'agreement among raft nodes before linearized reading' (duration: 642.300265ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T00:29:01.263915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"635.37091ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/alertmanagers/\" range_end:\"/registry/monitoring.coreos.com/alertmanagers0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"warn","ts":"2026-07-09T00:29:01.264452Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T00:29:00.621357Z","time spent":"643.081889ms","remote":"127.0.0.1:44144","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":10463,"request content":"key:\"/registry/pods/openstack/magnum-conductor-0\" "} {"level":"info","ts":"2026-07-09T00:29:01.264481Z","caller":"traceutil/trace.go:171","msg":"trace[170794364] range","detail":"{range_begin:/registry/monitoring.coreos.com/alertmanagers/; range_end:/registry/monitoring.coreos.com/alertmanagers0; response_count:0; response_revision:26081; }","duration":"636.002861ms","start":"2026-07-09T00:29:00.628446Z","end":"2026-07-09T00:29:01.264449Z","steps":["trace[170794364] 'agreement among raft nodes before linearized reading' (duration: 635.185565ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T00:29:01.264547Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T00:29:00.628426Z","time spent":"636.103254ms","remote":"127.0.0.1:54546","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":1,"response size":30,"request content":"key:\"/registry/monitoring.coreos.com/alertmanagers/\" range_end:\"/registry/monitoring.coreos.com/alertmanagers0\" count_only:true "} {"level":"info","ts":"2026-07-09T00:29:04.243303Z","caller":"traceutil/trace.go:171","msg":"trace[1226091008] linearizableReadLoop","detail":"{readStateIndex:26965; appliedIndex:26964; }","duration":"120.511483ms","start":"2026-07-09T00:29:04.122773Z","end":"2026-07-09T00:29:04.243284Z","steps":["trace[1226091008] 'read index received' (duration: 120.37973ms)","trace[1226091008] 'applied index is now lower than readState.Index' (duration: 130.623µs)"],"step_count":2} {"level":"info","ts":"2026-07-09T00:29:04.243376Z","caller":"traceutil/trace.go:171","msg":"trace[167434346] transaction","detail":"{read_only:false; response_revision:26109; number_of_response:1; }","duration":"120.999322ms","start":"2026-07-09T00:29:04.122348Z","end":"2026-07-09T00:29:04.243348Z","steps":["trace[167434346] 'process raft request' (duration: 120.818689ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T00:29:04.243552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.775387ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.177\" ","response":"range_response_count:1 size:140"} {"level":"info","ts":"2026-07-09T00:29:04.243578Z","caller":"traceutil/trace.go:171","msg":"trace[1176495903] range","detail":"{range_begin:/registry/masterleases/199.204.45.177; range_end:; response_count:1; response_revision:26109; }","duration":"120.857679ms","start":"2026-07-09T00:29:04.122715Z","end":"2026-07-09T00:29:04.243572Z","steps":["trace[1176495903] 'agreement among raft nodes before linearized reading' (duration: 120.639745ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T00:29:07.516958Z","caller":"traceutil/trace.go:171","msg":"trace[670575430] linearizableReadLoop","detail":"{readStateIndex:27052; appliedIndex:27048; }","duration":"223.220492ms","start":"2026-07-09T00:29:07.293712Z","end":"2026-07-09T00:29:07.516932Z","steps":["trace[670575430] 'read index received' (duration: 35.987737ms)","trace[670575430] 'applied index is now lower than readState.Index' (duration: 187.231295ms)"],"step_count":2} {"level":"warn","ts":"2026-07-09T00:29:07.517288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.576438ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-07-09T00:29:07.517379Z","caller":"traceutil/trace.go:171","msg":"trace[422713176] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26195; }","duration":"223.732711ms","start":"2026-07-09T00:29:07.293631Z","end":"2026-07-09T00:29:07.517364Z","steps":["trace[422713176] 'agreement among raft nodes before linearized reading' (duration: 223.514817ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T00:29:07.517557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.596154ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"info","ts":"2026-07-09T00:29:07.517662Z","caller":"traceutil/trace.go:171","msg":"trace[481249820] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26196; }","duration":"214.734077ms","start":"2026-07-09T00:29:07.302908Z","end":"2026-07-09T00:29:07.517642Z","steps":["trace[481249820] 'agreement among raft nodes before linearized reading' (duration: 214.467342ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T00:29:07.5179Z","caller":"traceutil/trace.go:171","msg":"trace[1547385171] transaction","detail":"{read_only:false; response_revision:26196; number_of_response:1; }","duration":"116.877492ms","start":"2026-07-09T00:29:07.400975Z","end":"2026-07-09T00:29:07.517853Z","steps":["trace[1547385171] 'process raft request' (duration: 116.263001ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T00:29:07.517975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.014742ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-07-09T00:29:07.518032Z","caller":"traceutil/trace.go:171","msg":"trace[1235905986] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26196; }","duration":"215.081623ms","start":"2026-07-09T00:29:07.302937Z","end":"2026-07-09T00:29:07.518018Z","steps":["trace[1235905986] 'agreement among raft nodes before linearized reading' (duration: 214.934511ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T00:29:07.518065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.268072ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-a9850b46-ab65-49bd-92d1-92f68df859f3\" ","response":"range_response_count:1 size:3644"} {"level":"info","ts":"2026-07-09T00:29:07.518104Z","caller":"traceutil/trace.go:171","msg":"trace[890111047] transaction","detail":"{read_only:false; response_revision:26193; number_of_response:1; }","duration":"227.020285ms","start":"2026-07-09T00:29:07.291073Z","end":"2026-07-09T00:29:07.518093Z","steps":["trace[890111047] 'process raft request' (duration: 225.591758ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T00:29:07.518113Z","caller":"traceutil/trace.go:171","msg":"trace[575849864] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-a9850b46-ab65-49bd-92d1-92f68df859f3; range_end:; response_count:1; response_revision:26196; }","duration":"207.345994ms","start":"2026-07-09T00:29:07.310751Z","end":"2026-07-09T00:29:07.518097Z","steps":["trace[575849864] 'agreement among raft nodes before linearized reading' (duration: 207.237912ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T00:29:07.518118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.227408ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-07-09T00:29:07.518252Z","caller":"traceutil/trace.go:171","msg":"trace[857432140] transaction","detail":"{read_only:false; response_revision:26195; number_of_response:1; }","duration":"225.795081ms","start":"2026-07-09T00:29:07.292447Z","end":"2026-07-09T00:29:07.518243Z","steps":["trace[857432140] 'process raft request' (duration: 224.434705ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T00:29:07.518165Z","caller":"traceutil/trace.go:171","msg":"trace[1325145629] transaction","detail":"{read_only:false; response_revision:26194; number_of_response:1; }","duration":"226.024066ms","start":"2026-07-09T00:29:07.292128Z","end":"2026-07-09T00:29:07.518152Z","steps":["trace[1325145629] 'process raft request' (duration: 224.710141ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T00:29:07.518357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.88846ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-07-09T00:29:07.518253Z","caller":"traceutil/trace.go:171","msg":"trace[1499031899] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26196; }","duration":"211.401551ms","start":"2026-07-09T00:29:07.306823Z","end":"2026-07-09T00:29:07.518225Z","steps":["trace[1499031899] 'agreement among raft nodes before linearized reading' (duration: 210.987723ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T00:29:07.518402Z","caller":"traceutil/trace.go:171","msg":"trace[258522565] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26196; }","duration":"211.958313ms","start":"2026-07-09T00:29:07.306433Z","end":"2026-07-09T00:29:07.518391Z","steps":["trace[258522565] 'agreement among raft nodes before linearized reading' (duration: 211.749429ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T00:29:14.429131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.454947ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-09T00:29:14.429307Z","caller":"traceutil/trace.go:171","msg":"trace[1828227225] linearizableReadLoop","detail":"{readStateIndex:27133; appliedIndex:27132; }","duration":"107.342248ms","start":"2026-07-09T00:29:14.321937Z","end":"2026-07-09T00:29:14.429279Z","steps":["trace[1828227225] 'read index received' (duration: 76.381µs)","trace[1828227225] 'applied index is now lower than readState.Index' (duration: 107.263857ms)"],"step_count":2} {"level":"warn","ts":"2026-07-09T00:29:14.429419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.47842ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-09T00:29:14.429461Z","caller":"traceutil/trace.go:171","msg":"trace[177363312] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:26273; }","duration":"107.572762ms","start":"2026-07-09T00:29:14.321872Z","end":"2026-07-09T00:29:14.429445Z","steps":["trace[177363312] 'agreement among raft nodes before linearized reading' (duration: 107.47563ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T00:29:14.429496Z","caller":"traceutil/trace.go:171","msg":"trace[1806267644] transaction","detail":"{read_only:false; response_revision:26273; number_of_response:1; }","duration":"142.358856ms","start":"2026-07-09T00:29:14.287054Z","end":"2026-07-09T00:29:14.429413Z","steps":["trace[1806267644] 'process raft request' (duration: 13.465741ms)","trace[1806267644] 'compare' (duration: 128.08444ms)"],"step_count":2} {"level":"warn","ts":"2026-07-09T00:29:14.67287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.563715ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-09T00:29:14.672998Z","caller":"traceutil/trace.go:171","msg":"trace[856918891] transaction","detail":"{read_only:false; response_revision:26274; number_of_response:1; }","duration":"188.124732ms","start":"2026-07-09T00:29:14.484853Z","end":"2026-07-09T00:29:14.672978Z","steps":["trace[856918891] 'process raft request' (duration: 69.356213ms)","trace[856918891] 'compare' (duration: 118.044585ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T00:29:20.751553Z","caller":"traceutil/trace.go:171","msg":"trace[1565244614] transaction","detail":"{read_only:false; response_revision:26324; number_of_response:1; }","duration":"109.804675ms","start":"2026-07-09T00:29:20.641719Z","end":"2026-07-09T00:29:20.751524Z","steps":["trace[1565244614] 'process raft request' (duration: 109.591441ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T00:29:20.79053Z","caller":"traceutil/trace.go:171","msg":"trace[299183047] transaction","detail":"{read_only:false; response_revision:26325; number_of_response:1; }","duration":"141.402698ms","start":"2026-07-09T00:29:20.649058Z","end":"2026-07-09T00:29:20.790461Z","steps":["trace[299183047] 'process raft request' (duration: 141.135573ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T00:29:25.108432Z","caller":"traceutil/trace.go:171","msg":"trace[1131315085] transaction","detail":"{read_only:false; response_revision:26363; number_of_response:1; }","duration":"114.272371ms","start":"2026-07-09T00:29:24.994108Z","end":"2026-07-09T00:29:25.108381Z","steps":["trace[1131315085] 'process raft request' (duration: 113.916424ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T00:29:33.217369Z","caller":"traceutil/trace.go:171","msg":"trace[1698620746] transaction","detail":"{read_only:false; response_revision:26443; number_of_response:1; }","duration":"100.548547ms","start":"2026-07-09T00:29:33.116791Z","end":"2026-07-09T00:29:33.217339Z","steps":["trace[1698620746] 'process raft request' (duration: 100.339943ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T00:29:36.915419Z","caller":"traceutil/trace.go:171","msg":"trace[1971649798] transaction","detail":"{read_only:false; response_revision:26479; number_of_response:1; }","duration":"111.009989ms","start":"2026-07-09T00:29:36.804384Z","end":"2026-07-09T00:29:36.915394Z","steps":["trace[1971649798] 'process raft request' (duration: 110.877016ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T00:29:41.859176Z","caller":"traceutil/trace.go:171","msg":"trace[1491091225] transaction","detail":"{read_only:false; response_revision:26524; number_of_response:1; }","duration":"123.010921ms","start":"2026-07-09T00:29:41.73614Z","end":"2026-07-09T00:29:41.859151Z","steps":["trace[1491091225] 'process raft request' (duration: 122.96548ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T00:29:41.859234Z","caller":"traceutil/trace.go:171","msg":"trace[63432644] transaction","detail":"{read_only:false; response_revision:26523; number_of_response:1; }","duration":"123.073922ms","start":"2026-07-09T00:29:41.736124Z","end":"2026-07-09T00:29:41.859197Z","steps":["trace[63432644] 'process raft request' (duration: 122.811667ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T00:29:41.890927Z","caller":"traceutil/trace.go:171","msg":"trace[2022199820] linearizableReadLoop","detail":"{readStateIndex:27391; appliedIndex:27388; }","duration":"140.812415ms","start":"2026-07-09T00:29:41.750094Z","end":"2026-07-09T00:29:41.890907Z","steps":["trace[2022199820] 'read index received' (duration: 108.951799ms)","trace[2022199820] 'applied index is now lower than readState.Index' (duration: 31.859476ms)"],"step_count":2} {"level":"warn","ts":"2026-07-09T00:29:41.89104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.931107ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/roles/\" range_end:\"/registry/openstack.k-orc.cloud/roles0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-09T00:29:41.891013Z","caller":"traceutil/trace.go:171","msg":"trace[1122060086] transaction","detail":"{read_only:false; response_revision:26525; number_of_response:1; }","duration":"154.817256ms","start":"2026-07-09T00:29:41.736143Z","end":"2026-07-09T00:29:41.890961Z","steps":["trace[1122060086] 'process raft request' (duration: 154.664343ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T00:29:41.891074Z","caller":"traceutil/trace.go:171","msg":"trace[1364241980] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/roles/; range_end:/registry/openstack.k-orc.cloud/roles0; response_count:0; response_revision:26525; }","duration":"141.05157ms","start":"2026-07-09T00:29:41.75001Z","end":"2026-07-09T00:29:41.891061Z","steps":["trace[1364241980] 'agreement among raft nodes before linearized reading' (duration: 140.966289ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T00:29:55.216872Z","caller":"traceutil/trace.go:171","msg":"trace[1220727598] transaction","detail":"{read_only:false; response_revision:26633; number_of_response:1; }","duration":"164.699389ms","start":"2026-07-09T00:29:55.052131Z","end":"2026-07-09T00:29:55.21683Z","steps":["trace[1220727598] 'process raft request' (duration: 164.421903ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T00:29:55.30717Z","caller":"traceutil/trace.go:171","msg":"trace[1401665525] transaction","detail":"{read_only:false; response_revision:26634; number_of_response:1; }","duration":"164.358641ms","start":"2026-07-09T00:29:55.142767Z","end":"2026-07-09T00:29:55.307125Z","steps":["trace[1401665525] 'process raft request' (duration: 157.791154ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T00:29:59.357715Z","caller":"traceutil/trace.go:171","msg":"trace[861538213] transaction","detail":"{read_only:false; response_revision:26665; number_of_response:1; }","duration":"121.785097ms","start":"2026-07-09T00:29:59.235908Z","end":"2026-07-09T00:29:59.357694Z","steps":["trace[861538213] 'process raft request' (duration: 121.602234ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T00:30:03.745405Z","caller":"traceutil/trace.go:171","msg":"trace[1209151890] transaction","detail":"{read_only:false; response_revision:26712; number_of_response:1; }","duration":"122.46373ms","start":"2026-07-09T00:30:03.622903Z","end":"2026-07-09T00:30:03.745367Z","steps":["trace[1209151890] 'process raft request' (duration: 122.240185ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T00:30:04.0368Z","caller":"traceutil/trace.go:171","msg":"trace[203568781] linearizableReadLoop","detail":"{readStateIndex:27586; appliedIndex:27582; }","duration":"217.289817ms","start":"2026-07-09T00:30:03.819488Z","end":"2026-07-09T00:30:04.036777Z","steps":["trace[203568781] 'read index received' (duration: 5.799132ms)","trace[203568781] 'applied index is now lower than readState.Index' (duration: 211.489745ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T00:30:04.03684Z","caller":"traceutil/trace.go:171","msg":"trace[1182689160] transaction","detail":"{read_only:false; response_revision:26714; number_of_response:1; }","duration":"278.806378ms","start":"2026-07-09T00:30:03.757998Z","end":"2026-07-09T00:30:04.036804Z","steps":["trace[1182689160] 'process raft request' (duration: 278.546032ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T00:30:04.036861Z","caller":"traceutil/trace.go:171","msg":"trace[1785147292] transaction","detail":"{read_only:false; response_revision:26715; number_of_response:1; }","duration":"278.554572ms","start":"2026-07-09T00:30:03.758267Z","end":"2026-07-09T00:30:04.036822Z","steps":["trace[1785147292] 'process raft request' (duration: 278.43419ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T00:30:04.036961Z","caller":"traceutil/trace.go:171","msg":"trace[810114732] transaction","detail":"{read_only:false; response_revision:26716; number_of_response:1; }","duration":"277.721447ms","start":"2026-07-09T00:30:03.759197Z","end":"2026-07-09T00:30:04.036918Z","steps":["trace[810114732] 'process raft request' (duration: 277.542284ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T00:30:04.037028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.536441ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-07-09T00:30:04.037059Z","caller":"traceutil/trace.go:171","msg":"trace[1522644621] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26716; }","duration":"217.617143ms","start":"2026-07-09T00:30:03.819432Z","end":"2026-07-09T00:30:04.037049Z","steps":["trace[1522644621] 'agreement among raft nodes before linearized reading' (duration: 217.48151ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T00:30:04.037207Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.148647ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-07-09T00:30:04.037288Z","caller":"traceutil/trace.go:171","msg":"trace[1714219696] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26716; }","duration":"135.279ms","start":"2026-07-09T00:30:03.901991Z","end":"2026-07-09T00:30:04.03727Z","steps":["trace[1714219696] 'agreement among raft nodes before linearized reading' (duration: 135.099467ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T00:30:04.197445Z","caller":"traceutil/trace.go:171","msg":"trace[615287514] transaction","detail":"{read_only:false; response_revision:26718; number_of_response:1; }","duration":"156.110932ms","start":"2026-07-09T00:30:04.04129Z","end":"2026-07-09T00:30:04.197401Z","steps":["trace[615287514] 'process raft request' (duration: 134.83151ms)","trace[615287514] 'compare' (duration: 21.053568ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T00:30:04.197772Z","caller":"traceutil/trace.go:171","msg":"trace[870225033] transaction","detail":"{read_only:false; response_revision:26719; number_of_response:1; }","duration":"156.109622ms","start":"2026-07-09T00:30:04.04164Z","end":"2026-07-09T00:30:04.197749Z","steps":["trace[870225033] 'process raft request' (duration: 155.716254ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T00:30:04.198392Z","caller":"traceutil/trace.go:171","msg":"trace[1415799803] transaction","detail":"{read_only:false; response_revision:26720; number_of_response:1; }","duration":"155.974509ms","start":"2026-07-09T00:30:04.042393Z","end":"2026-07-09T00:30:04.198367Z","steps":["trace[1415799803] 'process raft request' (duration: 155.208294ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T00:30:04.198741Z","caller":"traceutil/trace.go:171","msg":"trace[1015050865] transaction","detail":"{read_only:false; response_revision:26721; number_of_response:1; }","duration":"155.961718ms","start":"2026-07-09T00:30:04.042749Z","end":"2026-07-09T00:30:04.19871Z","steps":["trace[1015050865] 'process raft request' (duration: 155.411588ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T00:30:04.651246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.886026ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-07-09T00:30:04.65135Z","caller":"traceutil/trace.go:171","msg":"trace[1468136202] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:26722; }","duration":"190.068099ms","start":"2026-07-09T00:30:04.461263Z","end":"2026-07-09T00:30:04.651331Z","steps":["trace[1468136202] 'count revisions from in-memory index tree' (duration: 189.773154ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T00:31:55.043291Z","caller":"traceutil/trace.go:171","msg":"trace[1619516133] transaction","detail":"{read_only:false; response_revision:27855; number_of_response:1; }","duration":"200.818501ms","start":"2026-07-09T00:31:54.842437Z","end":"2026-07-09T00:31:55.043255Z","steps":["trace[1619516133] 'process raft request' (duration: 200.633637ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T00:31:55.076826Z","caller":"traceutil/trace.go:171","msg":"trace[948027891] linearizableReadLoop","detail":"{readStateIndex:28752; appliedIndex:28750; }","duration":"105.66638ms","start":"2026-07-09T00:31:54.971115Z","end":"2026-07-09T00:31:55.076781Z","steps":["trace[948027891] 'read index received' (duration: 72.021739ms)","trace[948027891] 'applied index is now lower than readState.Index' (duration: 33.643431ms)"],"step_count":2} {"level":"warn","ts":"2026-07-09T00:31:55.077404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.269782ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-ks-user\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-09T00:31:55.077512Z","caller":"traceutil/trace.go:171","msg":"trace[5877253] range","detail":"{range_begin:/registry/jobs/openstack/manila-ks-user; range_end:; response_count:0; response_revision:27856; }","duration":"106.435455ms","start":"2026-07-09T00:31:54.971059Z","end":"2026-07-09T00:31:55.077494Z","steps":["trace[5877253] 'agreement among raft nodes before linearized reading' (duration: 106.284292ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T00:31:55.076938Z","caller":"traceutil/trace.go:171","msg":"trace[2106812726] transaction","detail":"{read_only:false; response_revision:27856; number_of_response:1; }","duration":"180.140237ms","start":"2026-07-09T00:31:54.896785Z","end":"2026-07-09T00:31:55.076925Z","steps":["trace[2106812726] 'process raft request' (duration: 179.839162ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T00:31:55.096306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.923708ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-ks-endpoints\" ","response":"range_response_count:1 size:21419"} {"level":"info","ts":"2026-07-09T00:31:55.096365Z","caller":"traceutil/trace.go:171","msg":"trace[1612531086] range","detail":"{range_begin:/registry/jobs/openstack/manila-ks-endpoints; range_end:; response_count:1; response_revision:27857; }","duration":"124.008019ms","start":"2026-07-09T00:31:54.972339Z","end":"2026-07-09T00:31:55.096347Z","steps":["trace[1612531086] 'agreement among raft nodes before linearized reading' (duration: 123.875576ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T00:32:31.094421Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":25235} {"level":"info","ts":"2026-07-09T00:32:31.233501Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":25235,"took":"135.379125ms","hash":521894123,"current-db-size-bytes":60071936,"current-db-size":"60 MB","current-db-size-in-use-bytes":38100992,"current-db-size-in-use":"38 MB"} {"level":"info","ts":"2026-07-09T00:32:31.233563Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":521894123,"revision":25235,"compact-revision":22061} {"level":"info","ts":"2026-07-09T00:33:56.964304Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"7c53a18098324dc9","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-07-09T00:33:56.969337Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003} {"level":"info","ts":"2026-07-09T00:33:56.969423Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003} {"level":"info","ts":"2026-07-09T00:37:31.101445Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":28154} {"level":"info","ts":"2026-07-09T00:37:31.243418Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":28154,"took":"137.371209ms","hash":4202520058,"current-db-size-bytes":60071936,"current-db-size":"60 MB","current-db-size-in-use-bytes":34086912,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-07-09T00:37:31.243471Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4202520058,"revision":28154,"compact-revision":25235} {"level":"info","ts":"2026-07-09T00:42:31.110091Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":30737} {"level":"info","ts":"2026-07-09T00:42:31.253885Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":30737,"took":"138.981468ms","hash":214312775,"current-db-size-bytes":60071936,"current-db-size":"60 MB","current-db-size-in-use-bytes":30953472,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-07-09T00:42:31.253964Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":214312775,"revision":30737,"compact-revision":28154} {"level":"info","ts":"2026-07-09T00:47:31.118475Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":33010} {"level":"info","ts":"2026-07-09T00:47:31.268129Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":33010,"took":"142.828611ms","hash":3548101364,"current-db-size-bytes":61116416,"current-db-size":"61 MB","current-db-size-in-use-bytes":30564352,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-07-09T00:47:31.268209Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3548101364,"revision":33010,"compact-revision":30737} {"level":"info","ts":"2026-07-09T00:52:31.124867Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":35255} {"level":"info","ts":"2026-07-09T00:52:31.263565Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":35255,"took":"134.3478ms","hash":3526676199,"current-db-size-bytes":61116416,"current-db-size":"61 MB","current-db-size-in-use-bytes":30629888,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-07-09T00:52:31.26365Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3526676199,"revision":35255,"compact-revision":33010} {"level":"info","ts":"2026-07-09T00:55:09.575968Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"7c53a18098324dc9","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-07-09T00:55:09.580433Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004} {"level":"info","ts":"2026-07-09T00:55:09.580505Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004} {"level":"info","ts":"2026-07-09T00:57:31.130062Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":37562} {"level":"info","ts":"2026-07-09T00:57:31.251005Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":37562,"took":"116.07217ms","hash":661156873,"current-db-size-bytes":61116416,"current-db-size":"61 MB","current-db-size-in-use-bytes":30691328,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-07-09T00:57:31.251076Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":661156873,"revision":37562,"compact-revision":35255}