{"level":"warn","ts":"2026-09-08T15:45:36.34527Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-08T15:45:36.345405Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.239: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://162.253.55.239:2380","--initial-cluster=instance=https://162.253.55.239:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.239:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.239: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-09-08T15:45:36.345507Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-08T15:45:36.345518Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.239:2380"]} {"level":"info","ts":"2026-09-08T15:45:36.34554Z","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-09-08T15:45:36.34625Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.239:2379"]} {"level":"info","ts":"2026-09-08T15:45:36.346329Z","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://162.253.55.239:2380"],"listen-peer-urls":["https://162.253.55.239:2380"],"advertise-client-urls":["https://162.253.55.239:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.239:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.239: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-09-08T15:45:36.349362Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.787272ms"} {"level":"info","ts":"2026-09-08T15:45:36.364201Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"548b318b3528a14c","cluster-id":"8bf5e58b9331730a"} {"level":"info","ts":"2026-09-08T15:45:36.364387Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"548b318b3528a14c switched to configuration voters=()"} {"level":"info","ts":"2026-09-08T15:45:36.364435Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"548b318b3528a14c became follower at term 0"} {"level":"info","ts":"2026-09-08T15:45:36.364456Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 548b318b3528a14c [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-08T15:45:36.364468Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"548b318b3528a14c became follower at term 1"} {"level":"info","ts":"2026-09-08T15:45:36.364586Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"548b318b3528a14c switched to configuration voters=(6092017394910798156)"} {"level":"warn","ts":"2026-09-08T15:45:36.370967Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-08T15:45:36.372804Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-08T15:45:36.374306Z","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-09-08T15:45:36.377143Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"548b318b3528a14c","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-08T15:45:36.378524Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"548b318b3528a14c","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-08T15:45:36.379259Z","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-09-08T15:45:36.379475Z","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-09-08T15:45:36.379525Z","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-09-08T15:45:36.381845Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"548b318b3528a14c switched to configuration voters=(6092017394910798156)"} {"level":"info","ts":"2026-09-08T15:45:36.382115Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"8bf5e58b9331730a","local-member-id":"548b318b3528a14c","added-peer-id":"548b318b3528a14c","added-peer-peer-urls":["https://162.253.55.239:2380"]} {"level":"info","ts":"2026-09-08T15:45:36.383344Z","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-09-08T15:45:36.383461Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.239:2380"} {"level":"info","ts":"2026-09-08T15:45:36.383511Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.239:2380"} {"level":"info","ts":"2026-09-08T15:45:36.383692Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"548b318b3528a14c","initial-advertise-peer-urls":["https://162.253.55.239:2380"],"listen-peer-urls":["https://162.253.55.239:2380"],"advertise-client-urls":["https://162.253.55.239:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.239:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-08T15:45:36.383739Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-08T15:45:36.565656Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"548b318b3528a14c is starting a new election at term 1"} {"level":"info","ts":"2026-09-08T15:45:36.565769Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"548b318b3528a14c became pre-candidate at term 1"} {"level":"info","ts":"2026-09-08T15:45:36.565803Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"548b318b3528a14c received MsgPreVoteResp from 548b318b3528a14c at term 1"} {"level":"info","ts":"2026-09-08T15:45:36.565829Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"548b318b3528a14c became candidate at term 2"} {"level":"info","ts":"2026-09-08T15:45:36.565842Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"548b318b3528a14c received MsgVoteResp from 548b318b3528a14c at term 2"} {"level":"info","ts":"2026-09-08T15:45:36.565862Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"548b318b3528a14c became leader at term 2"} {"level":"info","ts":"2026-09-08T15:45:36.565879Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 548b318b3528a14c elected leader 548b318b3528a14c at term 2"} {"level":"info","ts":"2026-09-08T15:45:36.567187Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-08T15:45:36.567387Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"548b318b3528a14c","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.239:2379]}","request-path":"/0/members/548b318b3528a14c/attributes","cluster-id":"8bf5e58b9331730a","publish-timeout":"7s"} {"level":"info","ts":"2026-09-08T15:45:36.567497Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-08T15:45:36.567528Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-08T15:45:36.567851Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-08T15:45:36.567995Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-08T15:45:36.568466Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"8bf5e58b9331730a","local-member-id":"548b318b3528a14c","cluster-version":"3.5"} {"level":"info","ts":"2026-09-08T15:45:36.568586Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-08T15:45:36.568629Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-08T15:45:36.571682Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-08T15:45:36.571856Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.239:2379"} {"level":"info","ts":"2026-09-08T15:45:39.628074Z","caller":"traceutil/trace.go:171","msg":"trace[2044378877] transaction","detail":"{read_only:false; response_revision:116; number_of_response:1; }","duration":"109.371014ms","start":"2026-09-08T15:45:39.518679Z","end":"2026-09-08T15:45:39.62805Z","steps":["trace[2044378877] 'process raft request' (duration: 106.694094ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T15:45:56.710395Z","caller":"traceutil/trace.go:171","msg":"trace[950164747] linearizableReadLoop","detail":"{readStateIndex:400; appliedIndex:399; }","duration":"109.480248ms","start":"2026-09-08T15:45:56.600895Z","end":"2026-09-08T15:45:56.710375Z","steps":["trace[950164747] 'read index received' (duration: 109.341445ms)","trace[950164747] 'applied index is now lower than readState.Index' (duration: 138.163µs)"],"step_count":2} {"level":"info","ts":"2026-09-08T15:45:56.710438Z","caller":"traceutil/trace.go:171","msg":"trace[2033887213] transaction","detail":"{read_only:false; response_revision:385; number_of_response:1; }","duration":"200.646345ms","start":"2026-09-08T15:45:56.509768Z","end":"2026-09-08T15:45:56.710414Z","steps":["trace[2033887213] 'process raft request' (duration: 200.503942ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T15:45:56.710506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.607851ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-09-08T15:45:56.710564Z","caller":"traceutil/trace.go:171","msg":"trace[906376838] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:385; }","duration":"109.716582ms","start":"2026-09-08T15:45:56.60084Z","end":"2026-09-08T15:45:56.710557Z","steps":["trace[906376838] 'agreement among raft nodes before linearized reading' (duration: 109.60736ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T15:46:15.510491Z","caller":"traceutil/trace.go:171","msg":"trace[243969550] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"139.226507ms","start":"2026-09-08T15:46:15.371242Z","end":"2026-09-08T15:46:15.510469Z","steps":["trace[243969550] 'process raft request' (duration: 139.100354ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T15:46:15.519074Z","caller":"traceutil/trace.go:171","msg":"trace[907522716] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"142.24465ms","start":"2026-09-08T15:46:15.376796Z","end":"2026-09-08T15:46:15.519041Z","steps":["trace[907522716] 'process raft request' (duration: 141.2685ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T15:46:15.51915Z","caller":"traceutil/trace.go:171","msg":"trace[432885292] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"137.568372ms","start":"2026-09-08T15:46:15.381552Z","end":"2026-09-08T15:46:15.519121Z","steps":["trace[432885292] 'process raft request' (duration: 137.381058ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T15:46:15.519651Z","caller":"traceutil/trace.go:171","msg":"trace[1658429748] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"136.415937ms","start":"2026-09-08T15:46:15.383177Z","end":"2026-09-08T15:46:15.519593Z","steps":["trace[1658429748] 'process raft request' (duration: 135.809245ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T15:46:15.519656Z","caller":"traceutil/trace.go:171","msg":"trace[1849467327] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"135.538369ms","start":"2026-09-08T15:46:15.384101Z","end":"2026-09-08T15:46:15.519639Z","steps":["trace[1849467327] 'process raft request' (duration: 134.926027ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T15:46:15.519985Z","caller":"traceutil/trace.go:171","msg":"trace[825202242] transaction","detail":"{read_only:false; number_of_response:1; response_revision:500; }","duration":"135.54481ms","start":"2026-09-08T15:46:15.384421Z","end":"2026-09-08T15:46:15.519965Z","steps":["trace[825202242] 'process raft request' (duration: 134.740594ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T15:46:15.520302Z","caller":"traceutil/trace.go:171","msg":"trace[199358063] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"134.734583ms","start":"2026-09-08T15:46:15.385532Z","end":"2026-09-08T15:46:15.520267Z","steps":["trace[199358063] 'process raft request' (duration: 133.677772ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T15:46:15.520497Z","caller":"traceutil/trace.go:171","msg":"trace[607459256] transaction","detail":"{read_only:false; response_revision:502; number_of_response:1; }","duration":"134.618952ms","start":"2026-09-08T15:46:15.385835Z","end":"2026-09-08T15:46:15.520454Z","steps":["trace[607459256] 'process raft request' (duration: 134.299364ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T15:46:15.520748Z","caller":"traceutil/trace.go:171","msg":"trace[1096316900] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"132.66204ms","start":"2026-09-08T15:46:15.38806Z","end":"2026-09-08T15:46:15.520722Z","steps":["trace[1096316900] 'process raft request' (duration: 132.146849ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T15:46:15.520917Z","caller":"traceutil/trace.go:171","msg":"trace[259437744] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"130.809432ms","start":"2026-09-08T15:46:15.390089Z","end":"2026-09-08T15:46:15.520898Z","steps":["trace[259437744] 'process raft request' (duration: 130.181058ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T15:46:15.521098Z","caller":"traceutil/trace.go:171","msg":"trace[700904762] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"111.859167ms","start":"2026-09-08T15:46:15.409226Z","end":"2026-09-08T15:46:15.521086Z","steps":["trace[700904762] 'process raft request' (duration: 111.276595ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T15:46:15.525591Z","caller":"traceutil/trace.go:171","msg":"trace[1366099246] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"100.172654ms","start":"2026-09-08T15:46:15.4254Z","end":"2026-09-08T15:46:15.525572Z","steps":["trace[1366099246] 'process raft request' (duration: 99.713054ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T15:46:17.085755Z","caller":"traceutil/trace.go:171","msg":"trace[1891070477] linearizableReadLoop","detail":"{readStateIndex:592; appliedIndex:590; }","duration":"125.011001ms","start":"2026-09-08T15:46:16.960721Z","end":"2026-09-08T15:46:17.085732Z","steps":["trace[1891070477] 'read index received' (duration: 15.741897ms)","trace[1891070477] 'applied index is now lower than readState.Index' (duration: 109.268214ms)"],"step_count":2} {"level":"info","ts":"2026-09-08T15:46:17.085829Z","caller":"traceutil/trace.go:171","msg":"trace[1996851299] transaction","detail":"{read_only:false; response_revision:570; number_of_response:1; }","duration":"121.11899ms","start":"2026-09-08T15:46:16.964673Z","end":"2026-09-08T15:46:17.085792Z","steps":["trace[1996851299] 'process raft request' (duration: 121.006498ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T15:46:17.085867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.334336ms","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-09-08T15:46:17.085925Z","caller":"traceutil/trace.go:171","msg":"trace[1323627555] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:570; }","duration":"185.421788ms","start":"2026-09-08T15:46:16.900492Z","end":"2026-09-08T15:46:17.085914Z","steps":["trace[1323627555] 'agreement among raft nodes before linearized reading' (duration: 185.280555ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T15:46:17.085991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.952138ms","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-09-08T15:46:17.086029Z","caller":"traceutil/trace.go:171","msg":"trace[919823441] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:570; }","duration":"185.02406ms","start":"2026-09-08T15:46:16.900988Z","end":"2026-09-08T15:46:17.086012Z","steps":["trace[919823441] 'agreement among raft nodes before linearized reading' (duration: 184.894457ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T15:46:17.086022Z","caller":"traceutil/trace.go:171","msg":"trace[982921841] transaction","detail":"{read_only:false; response_revision:569; number_of_response:1; }","duration":"160.586881ms","start":"2026-09-08T15:46:16.925397Z","end":"2026-09-08T15:46:17.085984Z","steps":["trace[982921841] 'process raft request' (duration: 137.990551ms)","trace[982921841] 'compare' (duration: 22.147741ms)"],"step_count":2} {"level":"warn","ts":"2026-09-08T15:46:17.086074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.603974ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/referencegrants.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:7708"} {"level":"info","ts":"2026-09-08T15:46:17.086145Z","caller":"traceutil/trace.go:171","msg":"trace[2059390564] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/referencegrants.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:570; }","duration":"164.719907ms","start":"2026-09-08T15:46:16.921407Z","end":"2026-09-08T15:46:17.086127Z","steps":["trace[2059390564] 'agreement among raft nodes before linearized reading' (duration: 164.485622ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T15:46:22.487095Z","caller":"traceutil/trace.go:171","msg":"trace[2000909560] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"139.741118ms","start":"2026-09-08T15:46:22.347307Z","end":"2026-09-08T15:46:22.487048Z","steps":["trace[2000909560] 'process raft request' (duration: 139.496793ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T15:46:22.638818Z","caller":"traceutil/trace.go:171","msg":"trace[1922670805] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"132.215872ms","start":"2026-09-08T15:46:22.506582Z","end":"2026-09-08T15:46:22.638798Z","steps":["trace[1922670805] 'process raft request' (duration: 132.049467ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T15:46:23.095175Z","caller":"traceutil/trace.go:171","msg":"trace[1333520] linearizableReadLoop","detail":"{readStateIndex:628; appliedIndex:627; }","duration":"113.802067ms","start":"2026-09-08T15:46:22.981342Z","end":"2026-09-08T15:46:23.095144Z","steps":["trace[1333520] 'read index received' (duration: 112.879748ms)","trace[1333520] 'applied index is now lower than readState.Index' (duration: 921.219µs)"],"step_count":2} {"level":"info","ts":"2026-09-08T15:46:23.095261Z","caller":"traceutil/trace.go:171","msg":"trace[1798351540] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"163.485381ms","start":"2026-09-08T15:46:22.93173Z","end":"2026-09-08T15:46:23.095215Z","steps":["trace[1798351540] 'process raft request' (duration: 162.733416ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T15:46:23.09543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.061653ms","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-09-08T15:46:23.095486Z","caller":"traceutil/trace.go:171","msg":"trace[515043186] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:604; }","duration":"114.176786ms","start":"2026-09-08T15:46:22.981291Z","end":"2026-09-08T15:46:23.095468Z","steps":["trace[515043186] 'agreement among raft nodes before linearized reading' (duration: 113.976481ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T15:46:23.735681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"546.854798ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-08T15:46:23.736061Z","caller":"traceutil/trace.go:171","msg":"trace[75564564] linearizableReadLoop","detail":"{readStateIndex:630; appliedIndex:628; }","duration":"619.581491ms","start":"2026-09-08T15:46:23.116457Z","end":"2026-09-08T15:46:23.736038Z","steps":["trace[75564564] 'read index received' (duration: 71.518379ms)","trace[75564564] 'applied index is now lower than readState.Index' (duration: 548.061892ms)"],"step_count":2} {"level":"info","ts":"2026-09-08T15:46:23.73612Z","caller":"traceutil/trace.go:171","msg":"trace[2047229018] transaction","detail":"{read_only:false; response_revision:606; number_of_response:1; }","duration":"635.687016ms","start":"2026-09-08T15:46:23.10039Z","end":"2026-09-08T15:46:23.736077Z","steps":["trace[2047229018] 'process raft request' (duration: 635.516833ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T15:46:23.736358Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T15:46:23.100357Z","time spent":"635.84819ms","remote":"127.0.0.1:52236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-08T15:46:23.736592Z","caller":"traceutil/trace.go:171","msg":"trace[1201734625] transaction","detail":"{read_only:false; response_revision:605; number_of_response:1; }","duration":"699.111575ms","start":"2026-09-08T15:46:23.037371Z","end":"2026-09-08T15:46:23.736483Z","steps":["trace[1201734625] 'process raft request' (duration: 150.630754ms)","trace[1201734625] 'compare' (duration: 546.651654ms)"],"step_count":2} {"level":"warn","ts":"2026-09-08T15:46:23.736671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"620.184543ms","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-09-08T15:46:23.736756Z","caller":"traceutil/trace.go:171","msg":"trace[2024693379] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:607; }","duration":"620.338666ms","start":"2026-09-08T15:46:23.116395Z","end":"2026-09-08T15:46:23.736734Z","steps":["trace[2024693379] 'agreement among raft nodes before linearized reading' (duration: 619.972899ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T15:46:23.736809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"579.923577ms","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-09-08T15:46:23.736828Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T15:46:23.037345Z","time spent":"699.371791ms","remote":"127.0.0.1:52236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-08T15:46:23.736863Z","caller":"traceutil/trace.go:171","msg":"trace[886520510] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:607; }","duration":"580.02284ms","start":"2026-09-08T15:46:23.156828Z","end":"2026-09-08T15:46:23.736851Z","steps":["trace[886520510] 'agreement among raft nodes before linearized reading' (duration: 579.826755ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T15:46:23.736874Z","caller":"traceutil/trace.go:171","msg":"trace[1068660777] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"563.328982ms","start":"2026-09-08T15:46:23.17353Z","end":"2026-09-08T15:46:23.736859Z","steps":["trace[1068660777] 'process raft request' (duration: 562.457803ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T15:46:23.736895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T15:46:23.156796Z","time spent":"580.090291ms","remote":"127.0.0.1:52236","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-09-08T15:46:23.736762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.80186ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-08T15:46:23.736967Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T15:46:23.17349Z","time spent":"563.414124ms","remote":"127.0.0.1:52196","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-08T15:46:23.737054Z","caller":"traceutil/trace.go:171","msg":"trace[1992738261] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:607; }","duration":"316.19222ms","start":"2026-09-08T15:46:23.420794Z","end":"2026-09-08T15:46:23.736987Z","steps":["trace[1992738261] 'agreement among raft nodes before linearized reading' (duration: 315.834961ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T15:46:23.737143Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T15:46:23.42076Z","time spent":"316.365993ms","remote":"127.0.0.1:51954","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-09-08T15:46:23.736816Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T15:46:23.116222Z","time spent":"620.582282ms","remote":"127.0.0.1:52236","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-09-08T15:46:23.737698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"606.641623ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-09-08T15:46:23.737823Z","caller":"traceutil/trace.go:171","msg":"trace[863626681] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:607; }","duration":"606.812866ms","start":"2026-09-08T15:46:23.130941Z","end":"2026-09-08T15:46:23.737754Z","steps":["trace[863626681] 'agreement among raft nodes before linearized reading' (duration: 605.56362ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T15:46:23.737922Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T15:46:23.13091Z","time spent":"606.97375ms","remote":"127.0.0.1:52236","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-09-08T15:46:41.801791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"380.413395ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-08T15:46:41.801972Z","caller":"traceutil/trace.go:171","msg":"trace[932422495] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:773; }","duration":"380.672371ms","start":"2026-09-08T15:46:41.421269Z","end":"2026-09-08T15:46:41.801941Z","steps":["trace[932422495] 'range keys from in-memory index tree' (duration: 380.312004ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T15:46:41.802037Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T15:46:41.42125Z","time spent":"380.771952ms","remote":"127.0.0.1:51954","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-09-08T15:46:41.801876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.750771ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-x6stk\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-09-08T15:46:41.802205Z","caller":"traceutil/trace.go:171","msg":"trace[1309471946] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-x6stk; range_end:; response_count:1; response_revision:773; }","duration":"293.173159ms","start":"2026-09-08T15:46:41.509002Z","end":"2026-09-08T15:46:41.802175Z","steps":["trace[1309471946] 'range keys from in-memory index tree' (duration: 292.391183ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T15:47:12.309362Z","caller":"traceutil/trace.go:171","msg":"trace[186349733] transaction","detail":"{read_only:false; response_revision:1178; number_of_response:1; }","duration":"106.063132ms","start":"2026-09-08T15:47:12.203271Z","end":"2026-09-08T15:47:12.309334Z","steps":["trace[186349733] 'process raft request' (duration: 101.434527ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T15:47:12.649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.605043ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-08T15:47:12.64907Z","caller":"traceutil/trace.go:171","msg":"trace[2038982003] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1178; }","duration":"231.737376ms","start":"2026-09-08T15:47:12.417318Z","end":"2026-09-08T15:47:12.649056Z","steps":["trace[2038982003] 'range keys from in-memory index tree' (duration: 231.411679ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T15:47:37.094668Z","caller":"traceutil/trace.go:171","msg":"trace[2021122575] transaction","detail":"{read_only:false; response_revision:1454; number_of_response:1; }","duration":"155.377394ms","start":"2026-09-08T15:47:36.939262Z","end":"2026-09-08T15:47:37.09464Z","steps":["trace[2021122575] 'process raft request' (duration: 155.20119ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T15:48:03.066902Z","caller":"traceutil/trace.go:171","msg":"trace[1005095233] transaction","detail":"{read_only:false; response_revision:1867; number_of_response:1; }","duration":"117.817193ms","start":"2026-09-08T15:48:02.949046Z","end":"2026-09-08T15:48:03.066864Z","steps":["trace[1005095233] 'process raft request' (duration: 84.073109ms)","trace[1005095233] 'compare' (duration: 33.178111ms)"],"step_count":2} {"level":"warn","ts":"2026-09-08T15:48:03.545454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.246385ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-08T15:48:03.545721Z","caller":"traceutil/trace.go:171","msg":"trace[852955726] transaction","detail":"{read_only:false; response_revision:1869; number_of_response:1; }","duration":"472.489438ms","start":"2026-09-08T15:48:03.073196Z","end":"2026-09-08T15:48:03.545686Z","steps":["trace[852955726] 'process raft request' (duration: 267.902185ms)","trace[852955726] 'compare' (duration: 204.120892ms)"],"step_count":2} {"level":"info","ts":"2026-09-08T15:48:03.545765Z","caller":"traceutil/trace.go:171","msg":"trace[1625320758] transaction","detail":"{read_only:false; response_revision:1870; number_of_response:1; }","duration":"472.445177ms","start":"2026-09-08T15:48:03.073297Z","end":"2026-09-08T15:48:03.545742Z","steps":["trace[1625320758] 'process raft request' (duration: 472.267043ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T15:48:03.545871Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T15:48:03.073278Z","time spent":"472.54149ms","remote":"127.0.0.1:52242","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1529,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-08T15:48:03.545891Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T15:48:03.073163Z","time spent":"472.641272ms","remote":"127.0.0.1:52124","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":893,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-08T15:48:03.546037Z","caller":"traceutil/trace.go:171","msg":"trace[1499140488] transaction","detail":"{read_only:false; response_revision:1871; number_of_response:1; }","duration":"472.701863ms","start":"2026-09-08T15:48:03.073302Z","end":"2026-09-08T15:48:03.546004Z","steps":["trace[1499140488] 'process raft request' (duration: 472.383266ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T15:48:03.546126Z","caller":"traceutil/trace.go:171","msg":"trace[338367432] transaction","detail":"{read_only:false; response_revision:1872; number_of_response:1; }","duration":"471.129327ms","start":"2026-09-08T15:48:03.074982Z","end":"2026-09-08T15:48:03.546112Z","steps":["trace[338367432] 'process raft request' (duration: 470.934952ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T15:48:03.546216Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T15:48:03.074973Z","time spent":"471.204298ms","remote":"127.0.0.1:52242","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1471,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-08T15:48:03.546375Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T15:48:03.073284Z","time spent":"472.942678ms","remote":"127.0.0.1:52124","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":977,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-08T15:48:03.546585Z","caller":"traceutil/trace.go:171","msg":"trace[509427716] transaction","detail":"{read_only:false; response_revision:1873; number_of_response:1; }","duration":"354.930001ms","start":"2026-09-08T15:48:03.191643Z","end":"2026-09-08T15:48:03.546573Z","steps":["trace[509427716] 'process raft request' (duration: 354.409639ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T15:48:03.546481Z","caller":"traceutil/trace.go:171","msg":"trace[446084331] linearizableReadLoop","detail":"{readStateIndex:1947; appliedIndex:1942; }","duration":"126.614104ms","start":"2026-09-08T15:48:03.419846Z","end":"2026-09-08T15:48:03.54646Z","steps":["trace[446084331] 'read index received' (duration: 123.895622ms)","trace[446084331] 'applied index is now lower than readState.Index' (duration: 2.717212ms)"],"step_count":2} {"level":"warn","ts":"2026-09-08T15:48:03.546602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.755447ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-08T15:48:03.54669Z","caller":"traceutil/trace.go:171","msg":"trace[1266654684] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1873; }","duration":"126.89441ms","start":"2026-09-08T15:48:03.419782Z","end":"2026-09-08T15:48:03.546676Z","steps":["trace[1266654684] 'agreement among raft nodes before linearized reading' (duration: 126.739457ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T15:48:03.546698Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T15:48:03.191579Z","time spent":"355.071374ms","remote":"127.0.0.1:52236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-08T15:48:04.112169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.954691ms","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-09-08T15:48:04.112474Z","caller":"traceutil/trace.go:171","msg":"trace[78986132] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1874; }","duration":"195.33091ms","start":"2026-09-08T15:48:03.917121Z","end":"2026-09-08T15:48:04.112452Z","steps":["trace[78986132] 'range keys from in-memory index tree' (duration: 194.739627ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T15:48:10.376379Z","caller":"traceutil/trace.go:171","msg":"trace[830894680] linearizableReadLoop","detail":"{readStateIndex:2005; appliedIndex:2004; }","duration":"119.400924ms","start":"2026-09-08T15:48:10.256948Z","end":"2026-09-08T15:48:10.376348Z","steps":["trace[830894680] 'read index received' (duration: 114.47854ms)","trace[830894680] 'applied index is now lower than readState.Index' (duration: 4.920594ms)"],"step_count":2} {"level":"info","ts":"2026-09-08T15:48:10.376505Z","caller":"traceutil/trace.go:171","msg":"trace[1912439293] transaction","detail":"{read_only:false; response_revision:1930; number_of_response:1; }","duration":"119.606508ms","start":"2026-09-08T15:48:10.256866Z","end":"2026-09-08T15:48:10.376472Z","steps":["trace[1912439293] 'process raft request' (duration: 114.632653ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T15:48:10.376603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.629449ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.239\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-09-08T15:48:10.376661Z","caller":"traceutil/trace.go:171","msg":"trace[1242267927] range","detail":"{range_begin:/registry/masterleases/162.253.55.239; range_end:; response_count:1; response_revision:1930; }","duration":"119.782542ms","start":"2026-09-08T15:48:10.256866Z","end":"2026-09-08T15:48:10.376649Z","steps":["trace[1242267927] 'agreement among raft nodes before linearized reading' (duration: 119.589578ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T15:48:17.037783Z","caller":"traceutil/trace.go:171","msg":"trace[250673385] transaction","detail":"{read_only:false; response_revision:1987; number_of_response:1; }","duration":"127.555595ms","start":"2026-09-08T15:48:16.910187Z","end":"2026-09-08T15:48:17.037743Z","steps":["trace[250673385] 'process raft request' (duration: 120.130032ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T15:48:17.438072Z","caller":"traceutil/trace.go:171","msg":"trace[182635476] transaction","detail":"{read_only:false; response_revision:1988; number_of_response:1; }","duration":"157.968704ms","start":"2026-09-08T15:48:17.280056Z","end":"2026-09-08T15:48:17.438025Z","steps":["trace[182635476] 'process raft request' (duration: 157.667627ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T15:48:17.552724Z","caller":"traceutil/trace.go:171","msg":"trace[1959820364] transaction","detail":"{read_only:false; response_revision:1990; number_of_response:1; }","duration":"107.342594ms","start":"2026-09-08T15:48:17.445339Z","end":"2026-09-08T15:48:17.552681Z","steps":["trace[1959820364] 'process raft request' (duration: 107.035917ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T15:48:17.553015Z","caller":"traceutil/trace.go:171","msg":"trace[1351446377] transaction","detail":"{read_only:false; response_revision:1991; number_of_response:1; }","duration":"106.575435ms","start":"2026-09-08T15:48:17.446395Z","end":"2026-09-08T15:48:17.55297Z","steps":["trace[1351446377] 'process raft request' (duration: 106.178986ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T15:48:17.553318Z","caller":"traceutil/trace.go:171","msg":"trace[125119286] transaction","detail":"{read_only:false; response_revision:1992; number_of_response:1; }","duration":"104.939147ms","start":"2026-09-08T15:48:17.448333Z","end":"2026-09-08T15:48:17.553272Z","steps":["trace[125119286] 'process raft request' (duration: 104.530918ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T15:48:20.329219Z","caller":"traceutil/trace.go:171","msg":"trace[603390026] linearizableReadLoop","detail":"{readStateIndex:2085; appliedIndex:2084; }","duration":"113.64126ms","start":"2026-09-08T15:48:20.215548Z","end":"2026-09-08T15:48:20.32919Z","steps":["trace[603390026] 'read index received' (duration: 113.396304ms)","trace[603390026] 'applied index is now lower than readState.Index' (duration: 243.686µs)"],"step_count":2} {"level":"info","ts":"2026-09-08T15:48:20.329282Z","caller":"traceutil/trace.go:171","msg":"trace[852073631] transaction","detail":"{read_only:false; response_revision:2008; number_of_response:1; }","duration":"164.805514ms","start":"2026-09-08T15:48:20.164448Z","end":"2026-09-08T15:48:20.329254Z","steps":["trace[852073631] 'process raft request' (duration: 164.551768ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T15:48:20.329527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.942867ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-09-08T15:48:20.329609Z","caller":"traceutil/trace.go:171","msg":"trace[80170228] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2008; }","duration":"114.08969ms","start":"2026-09-08T15:48:20.215503Z","end":"2026-09-08T15:48:20.329593Z","steps":["trace[80170228] 'agreement among raft nodes before linearized reading' (duration: 113.838365ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T15:48:20.632531Z","caller":"traceutil/trace.go:171","msg":"trace[1187919130] transaction","detail":"{read_only:false; response_revision:2009; number_of_response:1; }","duration":"297.510519ms","start":"2026-09-08T15:48:20.334985Z","end":"2026-09-08T15:48:20.632495Z","steps":["trace[1187919130] 'process raft request' (duration: 271.454051ms)","trace[1187919130] 'compare' (duration: 25.695599ms)"],"step_count":2} {"level":"info","ts":"2026-09-08T15:48:20.632687Z","caller":"traceutil/trace.go:171","msg":"trace[1117949325] linearizableReadLoop","detail":"{readStateIndex:2089; appliedIndex:2086; }","duration":"210.091429ms","start":"2026-09-08T15:48:20.422434Z","end":"2026-09-08T15:48:20.632525Z","steps":["trace[1117949325] 'read index received' (duration: 184.021171ms)","trace[1117949325] 'applied index is now lower than readState.Index' (duration: 26.068568ms)"],"step_count":2} {"level":"info","ts":"2026-09-08T15:48:20.632783Z","caller":"traceutil/trace.go:171","msg":"trace[1693855057] transaction","detail":"{read_only:false; response_revision:2010; number_of_response:1; }","duration":"221.589279ms","start":"2026-09-08T15:48:20.41118Z","end":"2026-09-08T15:48:20.632769Z","steps":["trace[1693855057] 'process raft request' (duration: 221.203789ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T15:48:20.632882Z","caller":"traceutil/trace.go:171","msg":"trace[484200139] transaction","detail":"{read_only:false; response_revision:2011; number_of_response:1; }","duration":"220.028362ms","start":"2026-09-08T15:48:20.412823Z","end":"2026-09-08T15:48:20.632852Z","steps":["trace[484200139] 'process raft request' (duration: 219.644822ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T15:48:20.632928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.482779ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-08T15:48:20.632982Z","caller":"traceutil/trace.go:171","msg":"trace[1710499724] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2011; }","duration":"210.599192ms","start":"2026-09-08T15:48:20.422364Z","end":"2026-09-08T15:48:20.632964Z","steps":["trace[1710499724] 'agreement among raft nodes before linearized reading' (duration: 210.49292ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T15:48:20.633165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.305249ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-08T15:48:20.633311Z","caller":"traceutil/trace.go:171","msg":"trace[1285642938] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:2011; }","duration":"205.502514ms","start":"2026-09-08T15:48:20.427777Z","end":"2026-09-08T15:48:20.63328Z","steps":["trace[1285642938] 'agreement among raft nodes before linearized reading' (duration: 205.286369ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T15:48:59.344304Z","caller":"traceutil/trace.go:171","msg":"trace[2137298752] transaction","detail":"{read_only:false; response_revision:2224; number_of_response:1; }","duration":"133.910702ms","start":"2026-09-08T15:48:59.210335Z","end":"2026-09-08T15:48:59.344245Z","steps":["trace[2137298752] 'process raft request' (duration: 133.696547ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T15:49:00.284558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"574.500909ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/percona-xtradb-haproxy-0.18d3632a2766ac5a\" ","response":"range_response_count:1 size:846"} {"level":"info","ts":"2026-09-08T15:49:00.284723Z","caller":"traceutil/trace.go:171","msg":"trace[167555519] range","detail":"{range_begin:/registry/events/openstack/percona-xtradb-haproxy-0.18d3632a2766ac5a; range_end:; response_count:1; response_revision:2224; }","duration":"574.716684ms","start":"2026-09-08T15:48:59.709938Z","end":"2026-09-08T15:49:00.284655Z","steps":["trace[167555519] 'range keys from in-memory index tree' (duration: 574.189722ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T15:49:00.284771Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T15:48:59.709914Z","time spent":"574.844356ms","remote":"127.0.0.1:52038","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":869,"request content":"key:\"/registry/events/openstack/percona-xtradb-haproxy-0.18d3632a2766ac5a\" "} {"level":"warn","ts":"2026-09-08T15:49:00.594893Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11622841217237810718,"retry-timeout":"500ms"} {"level":"info","ts":"2026-09-08T15:49:00.611646Z","caller":"traceutil/trace.go:171","msg":"trace[1545632489] transaction","detail":"{read_only:false; response_revision:2225; number_of_response:1; }","duration":"719.712365ms","start":"2026-09-08T15:48:59.891904Z","end":"2026-09-08T15:49:00.611617Z","steps":["trace[1545632489] 'process raft request' (duration: 719.519181ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T15:49:00.611883Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T15:48:59.891879Z","time spent":"719.90368ms","remote":"127.0.0.1:52236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-08T15:49:00.686358Z","caller":"traceutil/trace.go:171","msg":"trace[274021713] linearizableReadLoop","detail":"{readStateIndex:2313; appliedIndex:2310; }","duration":"592.069788ms","start":"2026-09-08T15:49:00.094239Z","end":"2026-09-08T15:49:00.686309Z","steps":["trace[274021713] 'read index received' (duration: 517.149721ms)","trace[274021713] 'applied index is now lower than readState.Index' (duration: 74.918847ms)"],"step_count":2} {"level":"info","ts":"2026-09-08T15:49:00.686521Z","caller":"traceutil/trace.go:171","msg":"trace[1934095099] transaction","detail":"{read_only:false; response_revision:2226; number_of_response:1; }","duration":"399.078487ms","start":"2026-09-08T15:49:00.287397Z","end":"2026-09-08T15:49:00.686476Z","steps":["trace[1934095099] 'process raft request' (duration: 398.637827ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T15:49:00.686634Z","caller":"traceutil/trace.go:171","msg":"trace[756948329] transaction","detail":"{read_only:false; response_revision:2227; number_of_response:1; }","duration":"183.319106ms","start":"2026-09-08T15:49:00.503271Z","end":"2026-09-08T15:49:00.68659Z","steps":["trace[756948329] 'process raft request' (duration: 182.966797ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T15:49:00.68674Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T15:49:00.287373Z","time spent":"399.251242ms","remote":"127.0.0.1:52038","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":831,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-08T15:49:00.890774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"796.498065ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12386"} {"level":"warn","ts":"2026-09-08T15:49:00.890919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"793.014345ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-09-08T15:49:00.890981Z","caller":"traceutil/trace.go:171","msg":"trace[612824132] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2227; }","duration":"796.754331ms","start":"2026-09-08T15:49:00.094186Z","end":"2026-09-08T15:49:00.890941Z","steps":["trace[612824132] 'agreement among raft nodes before linearized reading' (duration: 592.695793ms)","trace[612824132] 'range keys from in-memory index tree' (duration: 203.633329ms)"],"step_count":2} {"level":"warn","ts":"2026-09-08T15:49:00.891002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"469.736355ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-08T15:49:00.891036Z","caller":"traceutil/trace.go:171","msg":"trace[1106113425] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2227; }","duration":"793.159769ms","start":"2026-09-08T15:49:00.09784Z","end":"2026-09-08T15:49:00.890999Z","steps":["trace[1106113425] 'agreement among raft nodes before linearized reading' (duration: 588.969647ms)","trace[1106113425] 'range keys from in-memory index tree' (duration: 203.868684ms)"],"step_count":2} {"level":"warn","ts":"2026-09-08T15:49:00.891064Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T15:49:00.094167Z","time spent":"796.875975ms","remote":"127.0.0.1:52142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12409,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"info","ts":"2026-09-08T15:49:00.891095Z","caller":"traceutil/trace.go:171","msg":"trace[1967866767] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2227; }","duration":"469.892399ms","start":"2026-09-08T15:49:00.421176Z","end":"2026-09-08T15:49:00.891069Z","steps":["trace[1967866767] 'agreement among raft nodes before linearized reading' (duration: 265.645456ms)","trace[1967866767] 'range keys from in-memory index tree' (duration: 204.071739ms)"],"step_count":2} {"level":"warn","ts":"2026-09-08T15:49:00.891135Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T15:49:00.097831Z","time spent":"793.288772ms","remote":"127.0.0.1:36080","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-09-08T15:49:00.891181Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T15:49:00.421146Z","time spent":"470.022743ms","remote":"127.0.0.1:51954","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-09-08T15:49:00.891342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.246934ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-08T15:49:00.891424Z","caller":"traceutil/trace.go:171","msg":"trace[1142344488] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:2227; }","duration":"355.653915ms","start":"2026-09-08T15:49:00.53575Z","end":"2026-09-08T15:49:00.891403Z","steps":["trace[1142344488] 'agreement among raft nodes before linearized reading' (duration: 151.098894ms)","trace[1142344488] 'count revisions from in-memory index tree' (duration: 204.15296ms)"],"step_count":2} {"level":"warn","ts":"2026-09-08T15:49:00.891474Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T15:49:00.535717Z","time spent":"355.745836ms","remote":"127.0.0.1:52116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":30,"request content":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true "} {"level":"warn","ts":"2026-09-08T15:49:00.892476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"631.892687ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.239\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-09-08T15:49:00.892625Z","caller":"traceutil/trace.go:171","msg":"trace[1548691740] range","detail":"{range_begin:/registry/masterleases/162.253.55.239; range_end:; response_count:1; response_revision:2227; }","duration":"632.110112ms","start":"2026-09-08T15:49:00.260478Z","end":"2026-09-08T15:49:00.892588Z","steps":["trace[1548691740] 'agreement among raft nodes before linearized reading' (duration: 426.365024ms)","trace[1548691740] 'range keys from in-memory index tree' (duration: 203.714921ms)"],"step_count":2} {"level":"warn","ts":"2026-09-08T15:49:00.892709Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T15:49:00.260456Z","time spent":"632.240616ms","remote":"127.0.0.1:51996","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/162.253.55.239\" "} {"level":"warn","ts":"2026-09-08T15:49:01.494097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.337558ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-08T15:49:01.494333Z","caller":"traceutil/trace.go:171","msg":"trace[784330090] transaction","detail":"{read_only:false; response_revision:2231; number_of_response:1; }","duration":"569.540983ms","start":"2026-09-08T15:49:00.924767Z","end":"2026-09-08T15:49:01.494308Z","steps":["trace[784330090] 'process raft request' (duration: 569.467481ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T15:49:01.494344Z","caller":"traceutil/trace.go:171","msg":"trace[1265921992] linearizableReadLoop","detail":"{readStateIndex:2317; appliedIndex:2316; }","duration":"570.070256ms","start":"2026-09-08T15:49:00.92424Z","end":"2026-09-08T15:49:01.49431Z","steps":["trace[1265921992] 'read index received' (duration: 271.359949ms)","trace[1265921992] 'applied index is now lower than readState.Index' (duration: 298.708097ms)"],"step_count":2} {"level":"info","ts":"2026-09-08T15:49:01.494346Z","caller":"traceutil/trace.go:171","msg":"trace[1706450779] transaction","detail":"{read_only:false; response_revision:2230; number_of_response:1; }","duration":"571.704373ms","start":"2026-09-08T15:49:00.92257Z","end":"2026-09-08T15:49:01.494274Z","steps":["trace[1706450779] 'process raft request' (duration: 273.073078ms)","trace[1706450779] 'compare' (duration: 298.194395ms)"],"step_count":2} {"level":"warn","ts":"2026-09-08T15:49:01.494423Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T15:49:00.924745Z","time spent":"569.642995ms","remote":"127.0.0.1:52236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-08T15:49:01.494777Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T15:49:00.92255Z","time spent":"572.056672ms","remote":"127.0.0.1:52236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-08T15:49:01.494821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"570.557777ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-09-08T15:49:01.494872Z","caller":"traceutil/trace.go:171","msg":"trace[595366846] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:2231; }","duration":"570.656259ms","start":"2026-09-08T15:49:00.9242Z","end":"2026-09-08T15:49:01.494856Z","steps":["trace[595366846] 'agreement among raft nodes before linearized reading' (duration: 570.24409ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T15:49:01.494923Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T15:49:00.924176Z","time spent":"570.736121ms","remote":"127.0.0.1:52242","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/endpointslices/default/kubernetes\" "} {"level":"warn","ts":"2026-09-08T15:49:01.505576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"554.130623ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-09-08T15:49:01.505652Z","caller":"traceutil/trace.go:171","msg":"trace[719633171] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2232; }","duration":"554.278907ms","start":"2026-09-08T15:49:00.951357Z","end":"2026-09-08T15:49:01.505636Z","steps":["trace[719633171] 'agreement among raft nodes before linearized reading' (duration: 554.065792ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T15:49:01.505706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"567.751942ms","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-09-08T15:49:01.505701Z","caller":"traceutil/trace.go:171","msg":"trace[1438427160] transaction","detail":"{read_only:false; response_revision:2232; number_of_response:1; }","duration":"154.023732ms","start":"2026-09-08T15:49:01.351617Z","end":"2026-09-08T15:49:01.505641Z","steps":["trace[1438427160] 'process raft request' (duration: 153.618233ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T15:49:01.505749Z","caller":"traceutil/trace.go:171","msg":"trace[812555807] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2232; }","duration":"567.867274ms","start":"2026-09-08T15:49:00.937867Z","end":"2026-09-08T15:49:01.505735Z","steps":["trace[812555807] 'agreement among raft nodes before linearized reading' (duration: 567.742612ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T15:49:01.505835Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T15:49:00.937845Z","time spent":"567.929855ms","remote":"127.0.0.1:52236","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-09-08T15:49:01.505712Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T15:49:00.951334Z","time spent":"554.37005ms","remote":"127.0.0.1:52236","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-09-08T15:49:01.505994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"481.07982ms","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-09-08T15:49:01.50608Z","caller":"traceutil/trace.go:171","msg":"trace[510369714] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2232; }","duration":"481.243594ms","start":"2026-09-08T15:49:01.024815Z","end":"2026-09-08T15:49:01.506058Z","steps":["trace[510369714] 'agreement among raft nodes before linearized reading' (duration: 481.007918ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T15:49:01.506129Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T15:49:01.024785Z","time spent":"481.334086ms","remote":"127.0.0.1:52236","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-09-08T15:49:01.50558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"576.201038ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-09-08T15:49:01.506399Z","caller":"traceutil/trace.go:171","msg":"trace[723592389] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2232; }","duration":"576.994956ms","start":"2026-09-08T15:49:00.929304Z","end":"2026-09-08T15:49:01.506299Z","steps":["trace[723592389] 'agreement among raft nodes before linearized reading' (duration: 576.052595ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T15:49:01.506606Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T15:49:00.929271Z","time spent":"577.225492ms","remote":"127.0.0.1:36080","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-09-08T15:49:01.900463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.455245ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-08T15:49:01.900649Z","caller":"traceutil/trace.go:171","msg":"trace[58585190] transaction","detail":"{read_only:false; response_revision:2234; number_of_response:1; }","duration":"388.973992ms","start":"2026-09-08T15:49:01.51166Z","end":"2026-09-08T15:49:01.900634Z","steps":["trace[58585190] 'process raft request' (duration: 388.902521ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T15:49:01.900735Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T15:49:01.511635Z","time spent":"389.073204ms","remote":"127.0.0.1:52236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-08T15:49:01.90081Z","caller":"traceutil/trace.go:171","msg":"trace[1585685301] transaction","detail":"{read_only:false; response_revision:2233; number_of_response:1; }","duration":"389.366611ms","start":"2026-09-08T15:49:01.511384Z","end":"2026-09-08T15:49:01.900751Z","steps":["trace[1585685301] 'process raft request' (duration: 173.535337ms)","trace[1585685301] 'compare' (duration: 215.297152ms)"],"step_count":2} {"level":"warn","ts":"2026-09-08T15:49:01.901021Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T15:49:01.511358Z","time spent":"389.560316ms","remote":"127.0.0.1:52236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-08T15:49:01.901047Z","caller":"traceutil/trace.go:171","msg":"trace[652769980] transaction","detail":"{read_only:false; response_revision:2235; number_of_response:1; }","duration":"388.980112ms","start":"2026-09-08T15:49:01.512033Z","end":"2026-09-08T15:49:01.901013Z","steps":["trace[652769980] 'process raft request' (duration: 388.569863ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T15:49:01.901224Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T15:49:01.512006Z","time spent":"389.122536ms","remote":"127.0.0.1:52236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-08T15:49:43.131878Z","caller":"traceutil/trace.go:171","msg":"trace[91436089] transaction","detail":"{read_only:false; response_revision:2629; number_of_response:1; }","duration":"286.758904ms","start":"2026-09-08T15:49:42.845104Z","end":"2026-09-08T15:49:43.131863Z","steps":["trace[91436089] 'process raft request' (duration: 286.655802ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T15:50:16.448449Z","caller":"traceutil/trace.go:171","msg":"trace[1035659485] transaction","detail":"{read_only:false; response_revision:2830; number_of_response:1; }","duration":"138.959204ms","start":"2026-09-08T15:50:16.309464Z","end":"2026-09-08T15:50:16.448423Z","steps":["trace[1035659485] 'process raft request' (duration: 138.7815ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T15:50:16.79004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.10967ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-08T15:50:16.790142Z","caller":"traceutil/trace.go:171","msg":"trace[969952287] linearizableReadLoop","detail":"{readStateIndex:2941; appliedIndex:2939; }","duration":"476.463705ms","start":"2026-09-08T15:50:16.313662Z","end":"2026-09-08T15:50:16.790125Z","steps":["trace[969952287] 'read index received' (duration: 134.663007ms)","trace[969952287] 'applied index is now lower than readState.Index' (duration: 341.799298ms)"],"step_count":2} {"level":"warn","ts":"2026-09-08T15:50:16.790328Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"476.66909ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-09-08T15:50:16.790263Z","caller":"traceutil/trace.go:171","msg":"trace[914423529] transaction","detail":"{read_only:false; response_revision:2831; number_of_response:1; }","duration":"478.124853ms","start":"2026-09-08T15:50:16.312097Z","end":"2026-09-08T15:50:16.790222Z","steps":["trace[914423529] 'process raft request' (duration: 311.725277ms)","trace[914423529] 'compare' (duration: 165.835534ms)"],"step_count":2} {"level":"info","ts":"2026-09-08T15:50:16.790369Z","caller":"traceutil/trace.go:171","msg":"trace[1590828209] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2831; }","duration":"476.763501ms","start":"2026-09-08T15:50:16.313591Z","end":"2026-09-08T15:50:16.790355Z","steps":["trace[1590828209] 'agreement among raft nodes before linearized reading' (duration: 476.620328ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T15:50:16.790403Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T15:50:16.313579Z","time spent":"476.814502ms","remote":"127.0.0.1:52236","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":"warn","ts":"2026-09-08T15:50:16.790416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.315395ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificaterequests/\" range_end:\"/registry/cert-manager.io/certificaterequests0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-08T15:50:16.790465Z","caller":"traceutil/trace.go:171","msg":"trace[1337261180] range","detail":"{range_begin:/registry/cert-manager.io/certificaterequests/; range_end:/registry/cert-manager.io/certificaterequests0; response_count:0; response_revision:2831; }","duration":"233.393537ms","start":"2026-09-08T15:50:16.55705Z","end":"2026-09-08T15:50:16.790444Z","steps":["trace[1337261180] 'agreement among raft nodes before linearized reading' (duration: 233.327166ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T15:50:16.790485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T15:50:16.312071Z","time spent":"478.319157ms","remote":"127.0.0.1:52236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-08T15:50:16.790329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.751603ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-08T15:50:16.791197Z","caller":"traceutil/trace.go:171","msg":"trace[302401494] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2831; }","duration":"370.428908ms","start":"2026-09-08T15:50:16.420522Z","end":"2026-09-08T15:50:16.79095Z","steps":["trace[302401494] 'agreement among raft nodes before linearized reading' (duration: 369.742752ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T15:50:16.791515Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T15:50:16.420506Z","time spent":"370.791176ms","remote":"127.0.0.1:51954","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-09-08T15:52:52.347385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.956743ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-08T15:52:52.34767Z","caller":"traceutil/trace.go:171","msg":"trace[1915715977] transaction","detail":"{read_only:false; response_revision:3811; number_of_response:1; }","duration":"117.145405ms","start":"2026-09-08T15:52:52.230503Z","end":"2026-09-08T15:52:52.347648Z","steps":["trace[1915715977] 'process raft request' (duration: 117.051423ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T15:52:52.347661Z","caller":"traceutil/trace.go:171","msg":"trace[662526689] transaction","detail":"{read_only:false; response_revision:3810; number_of_response:1; }","duration":"120.463162ms","start":"2026-09-08T15:52:52.227166Z","end":"2026-09-08T15:52:52.347629Z","steps":["trace[662526689] 'process raft request' (duration: 19.13321ms)","trace[662526689] 'compare' (duration: 100.778439ms)"],"step_count":2} {"level":"info","ts":"2026-09-08T15:53:24.065085Z","caller":"traceutil/trace.go:171","msg":"trace[1209612859] transaction","detail":"{read_only:false; response_revision:4020; number_of_response:1; }","duration":"407.64729ms","start":"2026-09-08T15:53:23.65741Z","end":"2026-09-08T15:53:24.065058Z","steps":["trace[1209612859] 'process raft request' (duration: 407.497846ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T15:53:24.065252Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T15:53:23.65739Z","time spent":"407.778653ms","remote":"127.0.0.1:52236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-08T15:53:24.065526Z","caller":"traceutil/trace.go:171","msg":"trace[687845169] linearizableReadLoop","detail":"{readStateIndex:4174; appliedIndex:4174; }","duration":"284.119397ms","start":"2026-09-08T15:53:23.781356Z","end":"2026-09-08T15:53:24.065475Z","steps":["trace[687845169] 'read index received' (duration: 284.094977ms)","trace[687845169] 'applied index is now lower than readState.Index' (duration: 20.2µs)"],"step_count":2} {"level":"warn","ts":"2026-09-08T15:53:24.06598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.550898ms","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-09-08T15:53:24.066163Z","caller":"traceutil/trace.go:171","msg":"trace[84132106] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4020; }","duration":"284.802624ms","start":"2026-09-08T15:53:23.781311Z","end":"2026-09-08T15:53:24.066114Z","steps":["trace[84132106] 'agreement among raft nodes before linearized reading' (duration: 284.269731ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T15:53:24.556828Z","caller":"traceutil/trace.go:171","msg":"trace[1762988435] transaction","detail":"{read_only:false; response_revision:4021; number_of_response:1; }","duration":"554.954911ms","start":"2026-09-08T15:53:24.001842Z","end":"2026-09-08T15:53:24.556797Z","steps":["trace[1762988435] 'process raft request' (duration: 554.666344ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T15:53:24.557037Z","caller":"traceutil/trace.go:171","msg":"trace[1769425227] linearizableReadLoop","detail":"{readStateIndex:4176; appliedIndex:4174; }","duration":"491.334617ms","start":"2026-09-08T15:53:24.065638Z","end":"2026-09-08T15:53:24.556973Z","steps":["trace[1769425227] 'read index received' (duration: 490.958898ms)","trace[1769425227] 'applied index is now lower than readState.Index' (duration: 373.699µs)"],"step_count":2} {"level":"warn","ts":"2026-09-08T15:53:24.557141Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T15:53:24.001794Z","time spent":"555.201466ms","remote":"127.0.0.1:52236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-08T15:53:24.557171Z","caller":"traceutil/trace.go:171","msg":"trace[1769378015] transaction","detail":"{read_only:false; response_revision:4022; number_of_response:1; }","duration":"553.267402ms","start":"2026-09-08T15:53:24.003834Z","end":"2026-09-08T15:53:24.557101Z","steps":["trace[1769378015] 'process raft request' (duration: 552.878513ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T15:53:24.557403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"652.359572ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-09-08T15:53:24.55751Z","caller":"traceutil/trace.go:171","msg":"trace[1556217187] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4022; }","duration":"652.530726ms","start":"2026-09-08T15:53:23.904951Z","end":"2026-09-08T15:53:24.557482Z","steps":["trace[1556217187] 'agreement among raft nodes before linearized reading' (duration: 652.190738ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T15:53:24.557537Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T15:53:24.003823Z","time spent":"553.59319ms","remote":"127.0.0.1:52236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-08T15:53:24.557599Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T15:53:23.904932Z","time spent":"652.620498ms","remote":"127.0.0.1:52236","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-09-08T15:53:24.598419Z","caller":"traceutil/trace.go:171","msg":"trace[1007069781] transaction","detail":"{read_only:false; response_revision:4023; number_of_response:1; }","duration":"527.377256ms","start":"2026-09-08T15:53:24.071022Z","end":"2026-09-08T15:53:24.598399Z","steps":["trace[1007069781] 'process raft request' (duration: 527.12665ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T15:53:24.598494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"385.932371ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-08T15:53:24.598586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.942976ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-08T15:53:24.598661Z","caller":"traceutil/trace.go:171","msg":"trace[1417571486] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:4023; }","duration":"386.195547ms","start":"2026-09-08T15:53:24.212439Z","end":"2026-09-08T15:53:24.598635Z","steps":["trace[1417571486] 'agreement among raft nodes before linearized reading' (duration: 385.937501ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T15:53:24.598688Z","caller":"traceutil/trace.go:171","msg":"trace[1965803153] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4023; }","duration":"178.126219ms","start":"2026-09-08T15:53:24.420536Z","end":"2026-09-08T15:53:24.598662Z","steps":["trace[1965803153] 'agreement among raft nodes before linearized reading' (duration: 177.889334ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T15:53:24.59871Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T15:53:24.212403Z","time spent":"386.297509ms","remote":"127.0.0.1:59358","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true "} {"level":"warn","ts":"2026-09-08T15:53:24.598678Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T15:53:24.070988Z","time spent":"527.54434ms","remote":"127.0.0.1:52236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-08T15:54:51.106171Z","caller":"traceutil/trace.go:171","msg":"trace[463378681] transaction","detail":"{read_only:false; response_revision:4990; number_of_response:1; }","duration":"129.100212ms","start":"2026-09-08T15:54:50.977049Z","end":"2026-09-08T15:54:51.106149Z","steps":["trace[463378681] 'process raft request' (duration: 29.208237ms)","trace[463378681] 'compare' (duration: 99.782093ms)"],"step_count":2} {"level":"info","ts":"2026-09-08T15:54:51.147331Z","caller":"traceutil/trace.go:171","msg":"trace[60041617] transaction","detail":"{read_only:false; response_revision:4991; number_of_response:1; }","duration":"164.870841ms","start":"2026-09-08T15:54:50.982429Z","end":"2026-09-08T15:54:51.1473Z","steps":["trace[60041617] 'process raft request' (duration: 164.669146ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T15:54:51.147327Z","caller":"traceutil/trace.go:171","msg":"trace[775998613] transaction","detail":"{read_only:false; response_revision:4992; number_of_response:1; }","duration":"144.016695ms","start":"2026-09-08T15:54:51.003288Z","end":"2026-09-08T15:54:51.147305Z","steps":["trace[775998613] 'process raft request' (duration: 143.932363ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T15:54:51.147504Z","caller":"traceutil/trace.go:171","msg":"trace[1092645300] linearizableReadLoop","detail":"{readStateIndex:5186; appliedIndex:5183; }","duration":"144.165527ms","start":"2026-09-08T15:54:51.003306Z","end":"2026-09-08T15:54:51.147471Z","steps":["trace[1092645300] 'read index received' (duration: 2.961307ms)","trace[1092645300] 'applied index is now lower than readState.Index' (duration: 141.20333ms)"],"step_count":2} {"level":"info","ts":"2026-09-08T15:54:51.147589Z","caller":"traceutil/trace.go:171","msg":"trace[302818662] transaction","detail":"{read_only:false; response_revision:4993; number_of_response:1; }","duration":"143.162354ms","start":"2026-09-08T15:54:51.004418Z","end":"2026-09-08T15:54:51.147581Z","steps":["trace[302818662] 'process raft request' (duration: 142.840487ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T15:54:51.149697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.377979ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-8491a107-4a90-47a5-8244-81341263e19c\" ","response":"range_response_count:1 size:3774"} {"level":"info","ts":"2026-09-08T15:54:51.149805Z","caller":"traceutil/trace.go:171","msg":"trace[1041079858] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-8491a107-4a90-47a5-8244-81341263e19c; range_end:; response_count:1; response_revision:4993; }","duration":"146.506291ms","start":"2026-09-08T15:54:51.003256Z","end":"2026-09-08T15:54:51.149763Z","steps":["trace[1041079858] 'agreement among raft nodes before linearized reading' (duration: 144.520875ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T15:54:55.502882Z","caller":"traceutil/trace.go:171","msg":"trace[1180629657] linearizableReadLoop","detail":"{readStateIndex:5294; appliedIndex:5293; }","duration":"140.477013ms","start":"2026-09-08T15:54:55.362383Z","end":"2026-09-08T15:54:55.50286Z","steps":["trace[1180629657] 'read index received' (duration: 140.34253ms)","trace[1180629657] 'applied index is now lower than readState.Index' (duration: 133.483µs)"],"step_count":2} {"level":"warn","ts":"2026-09-08T15:54:55.50322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.474883ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-slks4\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-09-08T15:54:55.503307Z","caller":"traceutil/trace.go:171","msg":"trace[254261761] range","detail":"{range_begin:/registry/pods/openstack/keepalived-slks4; range_end:; response_count:1; response_revision:5096; }","duration":"133.573706ms","start":"2026-09-08T15:54:55.369715Z","end":"2026-09-08T15:54:55.503288Z","steps":["trace[254261761] 'agreement among raft nodes before linearized reading' (duration: 133.33562ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T15:54:55.503383Z","caller":"traceutil/trace.go:171","msg":"trace[1317102194] transaction","detail":"{read_only:false; response_revision:5096; number_of_response:1; }","duration":"150.366609ms","start":"2026-09-08T15:54:55.352561Z","end":"2026-09-08T15:54:55.502928Z","steps":["trace[1317102194] 'process raft request' (duration: 150.174424ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T15:54:55.50393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.526647ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:50 size:2210296"} {"level":"info","ts":"2026-09-08T15:54:55.503973Z","caller":"traceutil/trace.go:171","msg":"trace[1775786527] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:50; response_revision:5096; }","duration":"141.598949ms","start":"2026-09-08T15:54:55.362363Z","end":"2026-09-08T15:54:55.503962Z","steps":["trace[1775786527] 'agreement among raft nodes before linearized reading' (duration: 140.636027ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T15:54:56.337553Z","caller":"traceutil/trace.go:171","msg":"trace[240288318] transaction","detail":"{read_only:false; response_revision:5115; number_of_response:1; }","duration":"102.759649ms","start":"2026-09-08T15:54:56.234776Z","end":"2026-09-08T15:54:56.337536Z","steps":["trace[240288318] 'process raft request' (duration: 102.641597ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T15:54:56.342285Z","caller":"traceutil/trace.go:171","msg":"trace[1433330215] transaction","detail":"{read_only:false; response_revision:5116; number_of_response:1; }","duration":"107.427897ms","start":"2026-09-08T15:54:56.234839Z","end":"2026-09-08T15:54:56.342267Z","steps":["trace[1433330215] 'process raft request' (duration: 107.252263ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T15:54:59.478927Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.915708ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-08T15:54:59.479016Z","caller":"traceutil/trace.go:171","msg":"trace[982722433] transaction","detail":"{read_only:false; response_revision:5247; number_of_response:1; }","duration":"417.312954ms","start":"2026-09-08T15:54:59.061688Z","end":"2026-09-08T15:54:59.479001Z","steps":["trace[982722433] 'process raft request' (duration: 264.273273ms)","trace[982722433] 'compare' (duration: 152.673853ms)"],"step_count":2} {"level":"warn","ts":"2026-09-08T15:54:59.479054Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T15:54:59.061638Z","time spent":"417.397126ms","remote":"127.0.0.1:52038","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":668,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-08T15:54:59.495803Z","caller":"traceutil/trace.go:171","msg":"trace[1240176808] transaction","detail":"{read_only:false; response_revision:5248; number_of_response:1; }","duration":"432.899992ms","start":"2026-09-08T15:54:59.062873Z","end":"2026-09-08T15:54:59.495773Z","steps":["trace[1240176808] 'process raft request' (duration: 432.709128ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T15:54:59.495954Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T15:54:59.062862Z","time spent":"433.014064ms","remote":"127.0.0.1:52422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5068,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-08T15:54:59.496098Z","caller":"traceutil/trace.go:171","msg":"trace[1308346643] transaction","detail":"{read_only:false; response_revision:5249; number_of_response:1; }","duration":"428.093241ms","start":"2026-09-08T15:54:59.067985Z","end":"2026-09-08T15:54:59.496078Z","steps":["trace[1308346643] 'process raft request' (duration: 427.721212ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T15:54:59.496226Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T15:54:59.067977Z","time spent":"428.194914ms","remote":"127.0.0.1:52142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5837,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-08T15:54:59.496362Z","caller":"traceutil/trace.go:171","msg":"trace[703740158] transaction","detail":"{read_only:false; response_revision:5250; number_of_response:1; }","duration":"300.677737ms","start":"2026-09-08T15:54:59.195665Z","end":"2026-09-08T15:54:59.496343Z","steps":["trace[703740158] 'process raft request' (duration: 300.321909ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T15:54:59.496423Z","caller":"traceutil/trace.go:171","msg":"trace[700007338] linearizableReadLoop","detail":"{readStateIndex:5450; appliedIndex:5448; }","duration":"431.886207ms","start":"2026-09-08T15:54:59.064523Z","end":"2026-09-08T15:54:59.496409Z","steps":["trace[700007338] 'read index received' (duration: 261.472019ms)","trace[700007338] 'applied index is now lower than readState.Index' (duration: 170.413318ms)"],"step_count":2} {"level":"warn","ts":"2026-09-08T15:54:59.496506Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T15:54:59.195642Z","time spent":"300.772249ms","remote":"127.0.0.1:52236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-08T15:54:59.496555Z","caller":"traceutil/trace.go:171","msg":"trace[1590404905] transaction","detail":"{read_only:false; response_revision:5252; number_of_response:1; }","duration":"253.777134ms","start":"2026-09-08T15:54:59.242767Z","end":"2026-09-08T15:54:59.496544Z","steps":["trace[1590404905] 'process raft request' (duration: 253.56987ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T15:54:59.496678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.134625ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-2bacdf19-7a03-47ff-8bce-1a5ec96bf80a\" ","response":"range_response_count:1 size:3601"} {"level":"info","ts":"2026-09-08T15:54:59.496721Z","caller":"traceutil/trace.go:171","msg":"trace[792037459] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-2bacdf19-7a03-47ff-8bce-1a5ec96bf80a; range_end:; response_count:1; response_revision:5252; }","duration":"377.214507ms","start":"2026-09-08T15:54:59.119496Z","end":"2026-09-08T15:54:59.49671Z","steps":["trace[792037459] 'agreement among raft nodes before linearized reading' (duration: 377.076134ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T15:54:59.496746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.750732ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"warn","ts":"2026-09-08T15:54:59.496802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.076384ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-08T15:54:59.496807Z","caller":"traceutil/trace.go:171","msg":"trace[1252324709] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5252; }","duration":"120.849764ms","start":"2026-09-08T15:54:59.375943Z","end":"2026-09-08T15:54:59.496792Z","steps":["trace[1252324709] 'agreement among raft nodes before linearized reading' (duration: 120.68067ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T15:54:59.496834Z","caller":"traceutil/trace.go:171","msg":"trace[1660719839] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:5252; }","duration":"147.149566ms","start":"2026-09-08T15:54:59.349676Z","end":"2026-09-08T15:54:59.496826Z","steps":["trace[1660719839] 'agreement among raft nodes before linearized reading' (duration: 147.099064ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T15:54:59.496757Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T15:54:59.119477Z","time spent":"377.266248ms","remote":"127.0.0.1:52142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3624,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-2bacdf19-7a03-47ff-8bce-1a5ec96bf80a\" "} {"level":"warn","ts":"2026-09-08T15:54:59.496986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"432.460181ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:25 size:787144"} {"level":"info","ts":"2026-09-08T15:54:59.497017Z","caller":"traceutil/trace.go:171","msg":"trace[231391953] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:25; response_revision:5252; }","duration":"432.513432ms","start":"2026-09-08T15:54:59.064495Z","end":"2026-09-08T15:54:59.497008Z","steps":["trace[231391953] 'agreement among raft nodes before linearized reading' (duration: 432.137863ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T15:54:59.497023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.504623ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/monitoring/vector\" ","response":"range_response_count:1 size:894"} {"level":"warn","ts":"2026-09-08T15:54:59.497043Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T15:54:59.064486Z","time spent":"432.548252ms","remote":"127.0.0.1:52058","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":25,"response size":787167,"request content":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" "} {"level":"warn","ts":"2026-09-08T15:54:59.497085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"371.598028ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-08T15:54:59.497114Z","caller":"traceutil/trace.go:171","msg":"trace[741898797] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:5252; }","duration":"371.68643ms","start":"2026-09-08T15:54:59.125421Z","end":"2026-09-08T15:54:59.497107Z","steps":["trace[741898797] 'agreement among raft nodes before linearized reading' (duration: 371.642359ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T15:54:59.497138Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T15:54:59.125402Z","time spent":"371.728711ms","remote":"127.0.0.1:59346","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":1,"response size":30,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"info","ts":"2026-09-08T15:54:59.497048Z","caller":"traceutil/trace.go:171","msg":"trace[1200811382] range","detail":"{range_begin:/registry/serviceaccounts/monitoring/vector; range_end:; response_count:1; response_revision:5252; }","duration":"213.563154ms","start":"2026-09-08T15:54:59.283477Z","end":"2026-09-08T15:54:59.49704Z","steps":["trace[1200811382] 'agreement among raft nodes before linearized reading' (duration: 213.484963ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T15:54:59.497432Z","caller":"traceutil/trace.go:171","msg":"trace[2039407580] transaction","detail":"{read_only:false; response_revision:5251; number_of_response:1; }","duration":"275.405268ms","start":"2026-09-08T15:54:59.220962Z","end":"2026-09-08T15:54:59.496367Z","steps":["trace[2039407580] 'process raft request' (duration: 275.287566ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T15:55:13.149748Z","caller":"traceutil/trace.go:171","msg":"trace[1504920307] transaction","detail":"{read_only:false; response_revision:5494; number_of_response:1; }","duration":"107.785456ms","start":"2026-09-08T15:55:13.041939Z","end":"2026-09-08T15:55:13.149724Z","steps":["trace[1504920307] 'process raft request' (duration: 107.730475ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T15:55:13.149789Z","caller":"traceutil/trace.go:171","msg":"trace[1240655341] transaction","detail":"{read_only:false; response_revision:5493; number_of_response:1; }","duration":"107.832047ms","start":"2026-09-08T15:55:13.041926Z","end":"2026-09-08T15:55:13.149758Z","steps":["trace[1240655341] 'process raft request' (duration: 21.545653ms)","trace[1240655341] 'compare' (duration: 86.021438ms)"],"step_count":2} {"level":"info","ts":"2026-09-08T15:55:13.997313Z","caller":"traceutil/trace.go:171","msg":"trace[158734616] linearizableReadLoop","detail":"{readStateIndex:5715; appliedIndex:5714; }","duration":"367.609187ms","start":"2026-09-08T15:55:13.629674Z","end":"2026-09-08T15:55:13.997284Z","steps":["trace[158734616] 'read index received' (duration: 367.419433ms)","trace[158734616] 'applied index is now lower than readState.Index' (duration: 188.584µs)"],"step_count":2} {"level":"info","ts":"2026-09-08T15:55:13.997382Z","caller":"traceutil/trace.go:171","msg":"trace[2035775106] transaction","detail":"{read_only:false; response_revision:5504; number_of_response:1; }","duration":"376.845289ms","start":"2026-09-08T15:55:13.620498Z","end":"2026-09-08T15:55:13.997343Z","steps":["trace[2035775106] 'process raft request' (duration: 376.615703ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T15:55:13.997592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.718288ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"warn","ts":"2026-09-08T15:55:13.99761Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T15:55:13.620474Z","time spent":"377.033213ms","remote":"127.0.0.1:52236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-08T15:55:13.997646Z","caller":"traceutil/trace.go:171","msg":"trace[201034463] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5504; }","duration":"338.824959ms","start":"2026-09-08T15:55:13.658808Z","end":"2026-09-08T15:55:13.997633Z","steps":["trace[201034463] 'agreement among raft nodes before linearized reading' (duration: 338.651404ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T15:55:13.997681Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T15:55:13.658787Z","time spent":"338.884881ms","remote":"127.0.0.1:52236","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-09-08T15:55:13.997685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"367.996697ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-09-08T15:55:13.997761Z","caller":"traceutil/trace.go:171","msg":"trace[821874241] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5504; }","duration":"368.09852ms","start":"2026-09-08T15:55:13.629643Z","end":"2026-09-08T15:55:13.997742Z","steps":["trace[821874241] 'agreement among raft nodes before linearized reading' (duration: 367.813142ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T15:55:13.99781Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T15:55:13.629632Z","time spent":"368.167461ms","remote":"127.0.0.1:52236","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":"warn","ts":"2026-09-08T15:55:13.997841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.366073ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-slks4\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-09-08T15:55:13.99792Z","caller":"traceutil/trace.go:171","msg":"trace[536808113] range","detail":"{range_begin:/registry/pods/openstack/keepalived-slks4; range_end:; response_count:1; response_revision:5504; }","duration":"336.502436ms","start":"2026-09-08T15:55:13.6614Z","end":"2026-09-08T15:55:13.997903Z","steps":["trace[536808113] 'agreement among raft nodes before linearized reading' (duration: 336.258341ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T15:55:13.997959Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T15:55:13.661388Z","time spent":"336.563518ms","remote":"127.0.0.1:52142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6547,"request content":"key:\"/registry/pods/openstack/keepalived-slks4\" "} {"level":"warn","ts":"2026-09-08T15:55:13.998166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.285928ms","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-09-08T15:55:13.998285Z","caller":"traceutil/trace.go:171","msg":"trace[1398564827] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5504; }","duration":"230.453261ms","start":"2026-09-08T15:55:13.767808Z","end":"2026-09-08T15:55:13.998261Z","steps":["trace[1398564827] 'agreement among raft nodes before linearized reading' (duration: 229.827447ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T15:55:21.522363Z","caller":"traceutil/trace.go:171","msg":"trace[860401860] transaction","detail":"{read_only:false; response_revision:5663; number_of_response:1; }","duration":"177.844919ms","start":"2026-09-08T15:55:21.34449Z","end":"2026-09-08T15:55:21.522335Z","steps":["trace[860401860] 'process raft request' (duration: 177.645484ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T15:55:21.552689Z","caller":"traceutil/trace.go:171","msg":"trace[1551980472] linearizableReadLoop","detail":"{readStateIndex:5880; appliedIndex:5878; }","duration":"132.502121ms","start":"2026-09-08T15:55:21.420162Z","end":"2026-09-08T15:55:21.552664Z","steps":["trace[1551980472] 'read index received' (duration: 101.981473ms)","trace[1551980472] 'applied index is now lower than readState.Index' (duration: 30.519758ms)"],"step_count":2} {"level":"warn","ts":"2026-09-08T15:55:21.552826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.653604ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-08T15:55:21.552863Z","caller":"traceutil/trace.go:171","msg":"trace[1049815746] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5664; }","duration":"132.749636ms","start":"2026-09-08T15:55:21.420103Z","end":"2026-09-08T15:55:21.552853Z","steps":["trace[1049815746] 'agreement among raft nodes before linearized reading' (duration: 132.669764ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T15:55:21.552839Z","caller":"traceutil/trace.go:171","msg":"trace[388776983] transaction","detail":"{read_only:false; response_revision:5664; number_of_response:1; }","duration":"198.751265ms","start":"2026-09-08T15:55:21.353981Z","end":"2026-09-08T15:55:21.552732Z","steps":["trace[388776983] 'process raft request' (duration: 198.54422ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T15:55:21.739973Z","caller":"traceutil/trace.go:171","msg":"trace[136070322] transaction","detail":"{read_only:false; response_revision:5665; number_of_response:1; }","duration":"146.275825ms","start":"2026-09-08T15:55:21.593676Z","end":"2026-09-08T15:55:21.739951Z","steps":["trace[136070322] 'process raft request' (duration: 146.142292ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T15:55:21.744051Z","caller":"traceutil/trace.go:171","msg":"trace[2136849385] transaction","detail":"{read_only:false; response_revision:5666; number_of_response:1; }","duration":"134.365263ms","start":"2026-09-08T15:55:21.609658Z","end":"2026-09-08T15:55:21.744023Z","steps":["trace[2136849385] 'process raft request' (duration: 134.195719ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T15:55:33.949888Z","caller":"traceutil/trace.go:171","msg":"trace[755655579] transaction","detail":"{read_only:false; response_revision:5822; number_of_response:1; }","duration":"149.591492ms","start":"2026-09-08T15:55:33.800262Z","end":"2026-09-08T15:55:33.949854Z","steps":["trace[755655579] 'process raft request' (duration: 149.522351ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T15:55:33.950292Z","caller":"traceutil/trace.go:171","msg":"trace[1788685414] transaction","detail":"{read_only:false; response_revision:5821; number_of_response:1; }","duration":"154.432842ms","start":"2026-09-08T15:55:33.79575Z","end":"2026-09-08T15:55:33.950182Z","steps":["trace[1788685414] 'process raft request' (duration: 124.054637ms)","trace[1788685414] 'compare' (duration: 29.806022ms)"],"step_count":2} {"level":"info","ts":"2026-09-08T15:55:36.839737Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2943} {"level":"info","ts":"2026-09-08T15:55:36.924071Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2943,"took":"82.805134ms","hash":769009001,"current-db-size-bytes":56152064,"current-db-size":"56 MB","current-db-size-in-use-bytes":32002048,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-09-08T15:55:36.924146Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":769009001,"revision":2943,"compact-revision":-1} {"level":"info","ts":"2026-09-08T15:56:26.254345Z","caller":"traceutil/trace.go:171","msg":"trace[1663189594] transaction","detail":"{read_only:false; response_revision:6272; number_of_response:1; }","duration":"104.777228ms","start":"2026-09-08T15:56:26.149542Z","end":"2026-09-08T15:56:26.254319Z","steps":["trace[1663189594] 'process raft request' (duration: 104.573523ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T16:00:36.846546Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5849} {"level":"info","ts":"2026-09-08T16:00:36.943339Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5849,"took":"94.275379ms","hash":912004497,"current-db-size-bytes":56152064,"current-db-size":"56 MB","current-db-size-in-use-bytes":26730496,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-09-08T16:00:36.943446Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":912004497,"revision":5849,"compact-revision":2943} {"level":"info","ts":"2026-09-08T16:01:38.062163Z","caller":"traceutil/trace.go:171","msg":"trace[1894819158] transaction","detail":"{read_only:false; response_revision:8554; number_of_response:1; }","duration":"469.118672ms","start":"2026-09-08T16:01:37.593016Z","end":"2026-09-08T16:01:38.062135Z","steps":["trace[1894819158] 'process raft request' (duration: 468.957658ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T16:01:38.062361Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T16:01:37.59298Z","time spent":"469.301876ms","remote":"127.0.0.1:52236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-08T16:01:38.064974Z","caller":"traceutil/trace.go:171","msg":"trace[699669968] transaction","detail":"{read_only:false; response_revision:8555; number_of_response:1; }","duration":"471.609959ms","start":"2026-09-08T16:01:37.593337Z","end":"2026-09-08T16:01:38.064947Z","steps":["trace[699669968] 'process raft request' (duration: 471.503877ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T16:01:38.065088Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T16:01:37.593289Z","time spent":"471.744492ms","remote":"127.0.0.1:52236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-08T16:01:49.46006Z","caller":"traceutil/trace.go:171","msg":"trace[1414625212] transaction","detail":"{read_only:false; response_revision:8615; number_of_response:1; }","duration":"109.790078ms","start":"2026-09-08T16:01:49.350205Z","end":"2026-09-08T16:01:49.459995Z","steps":["trace[1414625212] 'process raft request' (duration: 109.554553ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T16:01:50.435697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.771545ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-08T16:01:50.435819Z","caller":"traceutil/trace.go:171","msg":"trace[2116058641] transaction","detail":"{read_only:false; response_revision:8618; number_of_response:1; }","duration":"325.046447ms","start":"2026-09-08T16:01:50.110748Z","end":"2026-09-08T16:01:50.435794Z","steps":["trace[2116058641] 'process raft request' (duration: 87.067658ms)","trace[2116058641] 'compare' (duration: 237.625711ms)"],"step_count":2} {"level":"warn","ts":"2026-09-08T16:01:50.435896Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T16:01:50.110717Z","time spent":"325.139479ms","remote":"127.0.0.1:52236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-08T16:01:50.507035Z","caller":"traceutil/trace.go:171","msg":"trace[1641637372] linearizableReadLoop","detail":"{readStateIndex:8927; appliedIndex:8926; }","duration":"224.745046ms","start":"2026-09-08T16:01:50.282256Z","end":"2026-09-08T16:01:50.507001Z","steps":["trace[1641637372] 'read index received' (duration: 224.422128ms)","trace[1641637372] 'applied index is now lower than readState.Index' (duration: 321.358µs)"],"step_count":2} {"level":"info","ts":"2026-09-08T16:01:50.507083Z","caller":"traceutil/trace.go:171","msg":"trace[2077556277] transaction","detail":"{read_only:false; response_revision:8619; number_of_response:1; }","duration":"342.524949ms","start":"2026-09-08T16:01:50.164525Z","end":"2026-09-08T16:01:50.50705Z","steps":["trace[2077556277] 'process raft request' (duration: 342.295574ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T16:01:50.507252Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T16:01:50.164479Z","time spent":"342.684483ms","remote":"127.0.0.1:52236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-08T16:01:50.507308Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.038114ms","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-09-08T16:01:50.507347Z","caller":"traceutil/trace.go:171","msg":"trace[127462969] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8619; }","duration":"225.136366ms","start":"2026-09-08T16:01:50.282196Z","end":"2026-09-08T16:01:50.507333Z","steps":["trace[127462969] 'agreement among raft nodes before linearized reading' (duration: 224.963432ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T16:01:50.507405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.234361ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-09-08T16:01:50.507707Z","caller":"traceutil/trace.go:171","msg":"trace[262755190] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8619; }","duration":"209.587719ms","start":"2026-09-08T16:01:50.298099Z","end":"2026-09-08T16:01:50.507687Z","steps":["trace[262755190] 'agreement among raft nodes before linearized reading' (duration: 209.118808ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T16:01:50.507733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.24512ms","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-09-08T16:01:50.50773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.189915ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.239\" ","response":"range_response_count:1 size:135"} {"level":"warn","ts":"2026-09-08T16:01:50.507734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.308825ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"warn","ts":"2026-09-08T16:01:50.507782Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.742767ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-slks4\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-09-08T16:01:50.50779Z","caller":"traceutil/trace.go:171","msg":"trace[2005676947] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8619; }","duration":"178.321002ms","start":"2026-09-08T16:01:50.32945Z","end":"2026-09-08T16:01:50.507771Z","steps":["trace[2005676947] 'agreement among raft nodes before linearized reading' (duration: 177.972094ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T16:01:50.507851Z","caller":"traceutil/trace.go:171","msg":"trace[818354841] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8619; }","duration":"186.459018ms","start":"2026-09-08T16:01:50.321362Z","end":"2026-09-08T16:01:50.507821Z","steps":["trace[818354841] 'agreement among raft nodes before linearized reading' (duration: 185.933886ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T16:01:50.507861Z","caller":"traceutil/trace.go:171","msg":"trace[1466325715] range","detail":"{range_begin:/registry/pods/openstack/keepalived-slks4; range_end:; response_count:1; response_revision:8619; }","duration":"146.809818ms","start":"2026-09-08T16:01:50.361027Z","end":"2026-09-08T16:01:50.507836Z","steps":["trace[1466325715] 'agreement among raft nodes before linearized reading' (duration: 146.660215ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T16:01:50.507414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.327308ms","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-09-08T16:01:50.507799Z","caller":"traceutil/trace.go:171","msg":"trace[1680307741] range","detail":"{range_begin:/registry/masterleases/162.253.55.239; range_end:; response_count:1; response_revision:8619; }","duration":"201.317679ms","start":"2026-09-08T16:01:50.306462Z","end":"2026-09-08T16:01:50.507779Z","steps":["trace[1680307741] 'agreement among raft nodes before linearized reading' (duration: 200.854088ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T16:01:50.507966Z","caller":"traceutil/trace.go:171","msg":"trace[1810405716] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8619; }","duration":"170.90411ms","start":"2026-09-08T16:01:50.337028Z","end":"2026-09-08T16:01:50.507933Z","steps":["trace[1810405716] 'agreement among raft nodes before linearized reading' (duration: 170.223175ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T16:01:50.643822Z","caller":"traceutil/trace.go:171","msg":"trace[1380277502] transaction","detail":"{read_only:false; response_revision:8625; number_of_response:1; }","duration":"107.348952ms","start":"2026-09-08T16:01:50.536437Z","end":"2026-09-08T16:01:50.643786Z","steps":["trace[1380277502] 'process raft request' (duration: 107.123307ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T16:02:15.199849Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-000000000000238c.wal"} {"level":"info","ts":"2026-09-08T16:02:19.799122Z","caller":"traceutil/trace.go:171","msg":"trace[586524093] transaction","detail":"{read_only:false; response_revision:8831; number_of_response:1; }","duration":"229.405603ms","start":"2026-09-08T16:02:19.569694Z","end":"2026-09-08T16:02:19.7991Z","steps":["trace[586524093] 'process raft request' (duration: 229.230339ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T16:02:22.866961Z","caller":"traceutil/trace.go:171","msg":"trace[428988748] linearizableReadLoop","detail":"{readStateIndex:9166; appliedIndex:9165; }","duration":"101.223982ms","start":"2026-09-08T16:02:22.765715Z","end":"2026-09-08T16:02:22.866939Z","steps":["trace[428988748] 'read index received' (duration: 100.978347ms)","trace[428988748] 'applied index is now lower than readState.Index' (duration: 244.735µs)"],"step_count":2} {"level":"info","ts":"2026-09-08T16:02:22.867036Z","caller":"traceutil/trace.go:171","msg":"trace[1298188723] transaction","detail":"{read_only:false; response_revision:8849; number_of_response:1; }","duration":"104.253532ms","start":"2026-09-08T16:02:22.762754Z","end":"2026-09-08T16:02:22.867008Z","steps":["trace[1298188723] 'process raft request' (duration: 104.005176ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T16:02:22.867185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.454967ms","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-09-08T16:02:22.867243Z","caller":"traceutil/trace.go:171","msg":"trace[1023391211] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8849; }","duration":"101.57197ms","start":"2026-09-08T16:02:22.765658Z","end":"2026-09-08T16:02:22.86723Z","steps":["trace[1023391211] 'agreement among raft nodes before linearized reading' (duration: 101.367395ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T16:02:23.063218Z","caller":"traceutil/trace.go:171","msg":"trace[1038968359] transaction","detail":"{read_only:false; response_revision:8850; number_of_response:1; }","duration":"190.413648ms","start":"2026-09-08T16:02:22.87278Z","end":"2026-09-08T16:02:23.063194Z","steps":["trace[1038968359] 'process raft request' (duration: 146.355827ms)","trace[1038968359] 'compare' (duration: 43.956889ms)"],"step_count":2} {"level":"info","ts":"2026-09-08T16:02:23.243247Z","caller":"traceutil/trace.go:171","msg":"trace[536576248] linearizableReadLoop","detail":"{readStateIndex:9170; appliedIndex:9167; }","duration":"129.315737ms","start":"2026-09-08T16:02:23.11391Z","end":"2026-09-08T16:02:23.243226Z","steps":["trace[536576248] 'read index received' (duration: 129.094512ms)","trace[536576248] 'applied index is now lower than readState.Index' (duration: 220.615µs)"],"step_count":2} {"level":"warn","ts":"2026-09-08T16:02:23.243388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.452519ms","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:5"} {"level":"info","ts":"2026-09-08T16:02:23.243422Z","caller":"traceutil/trace.go:171","msg":"trace[416563615] transaction","detail":"{read_only:false; response_revision:8852; number_of_response:1; }","duration":"368.32807ms","start":"2026-09-08T16:02:22.875076Z","end":"2026-09-08T16:02:23.243404Z","steps":["trace[416563615] 'process raft request' (duration: 368.086354ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T16:02:23.243478Z","caller":"traceutil/trace.go:171","msg":"trace[1199374004] transaction","detail":"{read_only:false; response_revision:8853; number_of_response:1; }","duration":"367.882749ms","start":"2026-09-08T16:02:22.875586Z","end":"2026-09-08T16:02:23.243469Z","steps":["trace[1199374004] 'process raft request' (duration: 367.612563ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T16:02:23.243428Z","caller":"traceutil/trace.go:171","msg":"trace[404191016] range","detail":"{range_begin:/registry/rabbitmq.com/schemareplications/; range_end:/registry/rabbitmq.com/schemareplications0; response_count:0; response_revision:8853; }","duration":"129.557292ms","start":"2026-09-08T16:02:23.113857Z","end":"2026-09-08T16:02:23.243414Z","steps":["trace[404191016] 'agreement among raft nodes before linearized reading' (duration: 129.453829ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T16:02:23.243539Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T16:02:22.875569Z","time spent":"367.927771ms","remote":"127.0.0.1:52236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-08T16:02:23.243608Z","caller":"traceutil/trace.go:171","msg":"trace[1030844918] transaction","detail":"{read_only:false; response_revision:8851; number_of_response:1; }","duration":"369.586028ms","start":"2026-09-08T16:02:22.87396Z","end":"2026-09-08T16:02:23.243546Z","steps":["trace[1030844918] 'process raft request' (duration: 369.072576ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T16:02:23.243714Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T16:02:22.875047Z","time spent":"368.435562ms","remote":"127.0.0.1:52236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-08T16:02:23.243782Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T16:02:22.873953Z","time spent":"369.759982ms","remote":"127.0.0.1:52236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-08T16:02:31.59117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.185164ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-08T16:02:31.591274Z","caller":"traceutil/trace.go:171","msg":"trace[1628127804] transaction","detail":"{read_only:false; response_revision:8894; number_of_response:1; }","duration":"272.276966ms","start":"2026-09-08T16:02:31.318985Z","end":"2026-09-08T16:02:31.591262Z","steps":["trace[1628127804] 'process raft request' (duration: 98.947269ms)","trace[1628127804] 'compare' (duration: 173.095492ms)"],"step_count":2} {"level":"info","ts":"2026-09-08T16:02:31.591457Z","caller":"traceutil/trace.go:171","msg":"trace[1096284305] linearizableReadLoop","detail":"{readStateIndex:9214; appliedIndex:9212; }","duration":"172.67554ms","start":"2026-09-08T16:02:31.418735Z","end":"2026-09-08T16:02:31.591411Z","steps":["trace[1096284305] 'read index received' (duration: 157.059683ms)","trace[1096284305] 'applied index is now lower than readState.Index' (duration: 15.614567ms)"],"step_count":2} {"level":"info","ts":"2026-09-08T16:02:31.591558Z","caller":"traceutil/trace.go:171","msg":"trace[971199286] transaction","detail":"{read_only:false; response_revision:8895; number_of_response:1; }","duration":"272.45109ms","start":"2026-09-08T16:02:31.3191Z","end":"2026-09-08T16:02:31.591551Z","steps":["trace[971199286] 'process raft request' (duration: 272.136383ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T16:02:31.591646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.897256ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-08T16:02:31.591714Z","caller":"traceutil/trace.go:171","msg":"trace[543348287] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8895; }","duration":"173.02069ms","start":"2026-09-08T16:02:31.418672Z","end":"2026-09-08T16:02:31.591693Z","steps":["trace[543348287] 'agreement among raft nodes before linearized reading' (duration: 172.903706ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T16:02:32.500232Z","caller":"traceutil/trace.go:171","msg":"trace[1946634825] transaction","detail":"{read_only:false; response_revision:8897; number_of_response:1; }","duration":"175.523707ms","start":"2026-09-08T16:02:32.324682Z","end":"2026-09-08T16:02:32.500205Z","steps":["trace[1946634825] 'process raft request' (duration: 175.367404ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T16:02:32.768552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.761561ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-08T16:02:32.768675Z","caller":"traceutil/trace.go:171","msg":"trace[502017969] transaction","detail":"{read_only:false; response_revision:8898; number_of_response:1; }","duration":"420.930758ms","start":"2026-09-08T16:02:32.347713Z","end":"2026-09-08T16:02:32.768644Z","steps":["trace[502017969] 'process raft request' (duration: 249.006703ms)","trace[502017969] 'compare' (duration: 171.638619ms)"],"step_count":2} {"level":"info","ts":"2026-09-08T16:02:32.76872Z","caller":"traceutil/trace.go:171","msg":"trace[2129248587] transaction","detail":"{read_only:false; response_revision:8899; number_of_response:1; }","duration":"162.095989ms","start":"2026-09-08T16:02:32.606604Z","end":"2026-09-08T16:02:32.7687Z","steps":["trace[2129248587] 'process raft request' (duration: 162.040618ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T16:02:32.768795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.958526ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-08T16:02:32.768824Z","caller":"traceutil/trace.go:171","msg":"trace[1750284830] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8899; }","duration":"349.031058ms","start":"2026-09-08T16:02:32.419785Z","end":"2026-09-08T16:02:32.768817Z","steps":["trace[1750284830] 'agreement among raft nodes before linearized reading' (duration: 348.969646ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T16:02:32.768844Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T16:02:32.419763Z","time spent":"349.075658ms","remote":"127.0.0.1:51954","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-09-08T16:02:32.768732Z","caller":"traceutil/trace.go:171","msg":"trace[1032873038] linearizableReadLoop","detail":"{readStateIndex:9217; appliedIndex:9215; }","duration":"348.875065ms","start":"2026-09-08T16:02:32.419844Z","end":"2026-09-08T16:02:32.76872Z","steps":["trace[1032873038] 'read index received' (duration: 80.248682ms)","trace[1032873038] 'applied index is now lower than readState.Index' (duration: 268.625343ms)"],"step_count":2} {"level":"warn","ts":"2026-09-08T16:02:32.768899Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T16:02:32.347685Z","time spent":"421.04902ms","remote":"127.0.0.1:52236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-08T16:02:32.786083Z","caller":"traceutil/trace.go:171","msg":"trace[1993723858] transaction","detail":"{read_only:false; response_revision:8900; number_of_response:1; }","duration":"120.822042ms","start":"2026-09-08T16:02:32.665225Z","end":"2026-09-08T16:02:32.786048Z","steps":["trace[1993723858] 'process raft request' (duration: 120.666478ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T16:02:33.032599Z","caller":"traceutil/trace.go:171","msg":"trace[675537114] transaction","detail":"{read_only:false; response_revision:8901; number_of_response:1; }","duration":"142.480939ms","start":"2026-09-08T16:02:32.890094Z","end":"2026-09-08T16:02:33.032575Z","steps":["trace[675537114] 'process raft request' (duration: 137.471273ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T16:03:45.033359Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"548b318b3528a14c","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-09-08T16:03:45.039694Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-09-08T16:03:45.039817Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-09-08T16:04:01.42563Z","caller":"traceutil/trace.go:171","msg":"trace[1878700300] transaction","detail":"{read_only:false; response_revision:9751; number_of_response:1; }","duration":"352.851857ms","start":"2026-09-08T16:04:01.072753Z","end":"2026-09-08T16:04:01.425604Z","steps":["trace[1878700300] 'process raft request' (duration: 352.694744ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T16:04:01.42577Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T16:04:01.072729Z","time spent":"352.97156ms","remote":"127.0.0.1:52236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-08T16:04:01.467965Z","caller":"traceutil/trace.go:171","msg":"trace[1466132018] linearizableReadLoop","detail":"{readStateIndex:10097; appliedIndex:10095; }","duration":"310.534448ms","start":"2026-09-08T16:04:01.157409Z","end":"2026-09-08T16:04:01.467943Z","steps":["trace[1466132018] 'read index received' (duration: 268.025325ms)","trace[1466132018] 'applied index is now lower than readState.Index' (duration: 42.508303ms)"],"step_count":2} {"level":"warn","ts":"2026-09-08T16:04:01.468087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.65511ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/podmonitors/\" range_end:\"/registry/monitoring.coreos.com/podmonitors0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-08T16:04:01.468118Z","caller":"traceutil/trace.go:171","msg":"trace[982378036] range","detail":"{range_begin:/registry/monitoring.coreos.com/podmonitors/; range_end:/registry/monitoring.coreos.com/podmonitors0; response_count:0; response_revision:9752; }","duration":"310.750103ms","start":"2026-09-08T16:04:01.157358Z","end":"2026-09-08T16:04:01.468108Z","steps":["trace[982378036] 'agreement among raft nodes before linearized reading' (duration: 310.665031ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T16:04:01.468157Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T16:04:01.157336Z","time spent":"310.813275ms","remote":"127.0.0.1:34208","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":6,"response size":30,"request content":"key:\"/registry/monitoring.coreos.com/podmonitors/\" range_end:\"/registry/monitoring.coreos.com/podmonitors0\" count_only:true "} {"level":"info","ts":"2026-09-08T16:04:01.46819Z","caller":"traceutil/trace.go:171","msg":"trace[1720798929] transaction","detail":"{read_only:false; response_revision:9752; number_of_response:1; }","duration":"388.31563ms","start":"2026-09-08T16:04:01.07985Z","end":"2026-09-08T16:04:01.468166Z","steps":["trace[1720798929] 'process raft request' (duration: 357.283839ms)","trace[1720798929] 'compare' (duration: 30.712293ms)"],"step_count":2} {"level":"warn","ts":"2026-09-08T16:04:01.468329Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T16:04:01.079832Z","time spent":"388.410882ms","remote":"127.0.0.1:52236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-08T16:04:01.703656Z","caller":"traceutil/trace.go:171","msg":"trace[220338867] linearizableReadLoop","detail":"{readStateIndex:10098; appliedIndex:10097; }","duration":"141.96673ms","start":"2026-09-08T16:04:01.561666Z","end":"2026-09-08T16:04:01.703633Z","steps":["trace[220338867] 'read index received' (duration: 49.711968ms)","trace[220338867] 'applied index is now lower than readState.Index' (duration: 92.253762ms)"],"step_count":2} {"level":"info","ts":"2026-09-08T16:04:01.703791Z","caller":"traceutil/trace.go:171","msg":"trace[1450333389] transaction","detail":"{read_only:false; response_revision:9753; number_of_response:1; }","duration":"143.750831ms","start":"2026-09-08T16:04:01.560004Z","end":"2026-09-08T16:04:01.703755Z","steps":["trace[1450333389] 'process raft request' (duration: 51.411438ms)","trace[1450333389] 'compare' (duration: 92.115968ms)"],"step_count":2} {"level":"warn","ts":"2026-09-08T16:04:01.703861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.181915ms","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-09-08T16:04:01.703897Z","caller":"traceutil/trace.go:171","msg":"trace[646330837] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:9753; }","duration":"142.255696ms","start":"2026-09-08T16:04:01.561632Z","end":"2026-09-08T16:04:01.703888Z","steps":["trace[646330837] 'agreement among raft nodes before linearized reading' (duration: 142.121683ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T16:05:36.855639Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8035} {"level":"info","ts":"2026-09-08T16:05:36.927428Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8035,"took":"69.770635ms","hash":301673970,"current-db-size-bytes":56152064,"current-db-size":"56 MB","current-db-size-in-use-bytes":28033024,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-09-08T16:05:36.927492Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":301673970,"revision":8035,"compact-revision":5849} {"level":"info","ts":"2026-09-08T16:09:36.054503Z","caller":"traceutil/trace.go:171","msg":"trace[329368897] transaction","detail":"{read_only:false; response_revision:12162; number_of_response:1; }","duration":"115.739356ms","start":"2026-09-08T16:09:35.938721Z","end":"2026-09-08T16:09:36.054461Z","steps":["trace[329368897] 'process raft request' (duration: 98.780098ms)","trace[329368897] 'compare' (duration: 16.819165ms)"],"step_count":2} {"level":"info","ts":"2026-09-08T16:09:43.007092Z","caller":"traceutil/trace.go:171","msg":"trace[832171887] transaction","detail":"{read_only:false; response_revision:12197; number_of_response:1; }","duration":"234.759353ms","start":"2026-09-08T16:09:42.772304Z","end":"2026-09-08T16:09:43.007064Z","steps":["trace[832171887] 'process raft request' (duration: 234.575419ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T16:09:43.062512Z","caller":"traceutil/trace.go:171","msg":"trace[1395894875] transaction","detail":"{read_only:false; response_revision:12198; number_of_response:1; }","duration":"287.352221ms","start":"2026-09-08T16:09:42.775127Z","end":"2026-09-08T16:09:43.06248Z","steps":["trace[1395894875] 'process raft request' (duration: 287.157907ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T16:09:43.062709Z","caller":"traceutil/trace.go:171","msg":"trace[59737733] transaction","detail":"{read_only:false; response_revision:12199; number_of_response:1; }","duration":"267.048425ms","start":"2026-09-08T16:09:42.795633Z","end":"2026-09-08T16:09:43.062682Z","steps":["trace[59737733] 'process raft request' (duration: 266.798119ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T16:10:36.862226Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10395} {"level":"info","ts":"2026-09-08T16:10:36.952469Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10395,"took":"87.626894ms","hash":2886710005,"current-db-size-bytes":56152064,"current-db-size":"56 MB","current-db-size-in-use-bytes":25817088,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-09-08T16:10:36.95253Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2886710005,"revision":10395,"compact-revision":8035} {"level":"info","ts":"2026-09-08T16:15:36.87102Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12564} {"level":"info","ts":"2026-09-08T16:15:36.983288Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12564,"took":"108.957067ms","hash":168202440,"current-db-size-bytes":56152064,"current-db-size":"56 MB","current-db-size-in-use-bytes":27967488,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-09-08T16:15:36.983361Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":168202440,"revision":12564,"compact-revision":10395} {"level":"info","ts":"2026-09-08T16:15:50.572933Z","caller":"traceutil/trace.go:171","msg":"trace[556140813] linearizableReadLoop","detail":"{readStateIndex:15200; appliedIndex:15198; }","duration":"153.331768ms","start":"2026-09-08T16:15:50.419577Z","end":"2026-09-08T16:15:50.572909Z","steps":["trace[556140813] 'read index received' (duration: 182.694µs)","trace[556140813] 'applied index is now lower than readState.Index' (duration: 153.148264ms)"],"step_count":2} {"level":"info","ts":"2026-09-08T16:15:50.573167Z","caller":"traceutil/trace.go:171","msg":"trace[1150435681] transaction","detail":"{read_only:false; response_revision:14686; number_of_response:1; }","duration":"166.996221ms","start":"2026-09-08T16:15:50.406152Z","end":"2026-09-08T16:15:50.573148Z","steps":["trace[1150435681] 'process raft request' (duration: 154.073194ms)","trace[1150435681] 'compare' (duration: 12.556199ms)"],"step_count":2} {"level":"warn","ts":"2026-09-08T16:15:50.573445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.835939ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-08T16:15:50.573537Z","caller":"traceutil/trace.go:171","msg":"trace[168153350] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:14686; }","duration":"153.975122ms","start":"2026-09-08T16:15:50.419535Z","end":"2026-09-08T16:15:50.57351Z","steps":["trace[168153350] 'agreement among raft nodes before linearized reading' (duration: 153.818379ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T16:15:50.574422Z","caller":"traceutil/trace.go:171","msg":"trace[1300593634] transaction","detail":"{read_only:false; response_revision:14687; number_of_response:1; }","duration":"137.463163ms","start":"2026-09-08T16:15:50.436928Z","end":"2026-09-08T16:15:50.574392Z","steps":["trace[1300593634] 'process raft request' (duration: 137.248817ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T16:15:50.574602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.201392ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:422"} {"level":"info","ts":"2026-09-08T16:15:50.574699Z","caller":"traceutil/trace.go:171","msg":"trace[1764227863] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:14687; }","duration":"152.341815ms","start":"2026-09-08T16:15:50.42234Z","end":"2026-09-08T16:15:50.574681Z","steps":["trace[1764227863] 'agreement among raft nodes before linearized reading' (duration: 151.980886ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T16:16:15.062589Z","caller":"traceutil/trace.go:171","msg":"trace[1140422459] transaction","detail":"{read_only:false; response_revision:14812; number_of_response:1; }","duration":"100.610714ms","start":"2026-09-08T16:16:14.961946Z","end":"2026-09-08T16:16:15.062557Z","steps":["trace[1140422459] 'process raft request' (duration: 100.479351ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T16:16:32.330071Z","caller":"traceutil/trace.go:171","msg":"trace[1239918448] transaction","detail":"{read_only:false; response_revision:14913; number_of_response:1; }","duration":"111.28634ms","start":"2026-09-08T16:16:32.218763Z","end":"2026-09-08T16:16:32.33005Z","steps":["trace[1239918448] 'process raft request' (duration: 111.145747ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T16:16:32.888756Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11622841217237843914,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-09-08T16:16:33.389696Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11622841217237843914,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-09-08T16:16:33.607254Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.271382965s","expected-duration":"1s"} {"level":"info","ts":"2026-09-08T16:16:33.607783Z","caller":"traceutil/trace.go:171","msg":"trace[1629233099] transaction","detail":"{read_only:false; response_revision:14914; number_of_response:1; }","duration":"1.271972598s","start":"2026-09-08T16:16:32.335782Z","end":"2026-09-08T16:16:33.607755Z","steps":["trace[1629233099] 'process raft request' (duration: 1.271770764s)"],"step_count":1} {"level":"warn","ts":"2026-09-08T16:16:33.608116Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T16:16:32.335769Z","time spent":"1.272251205s","remote":"127.0.0.1:52236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-08T16:16:33.717161Z","caller":"traceutil/trace.go:171","msg":"trace[1050318777] transaction","detail":"{read_only:false; response_revision:14915; number_of_response:1; }","duration":"959.307726ms","start":"2026-09-08T16:16:32.757821Z","end":"2026-09-08T16:16:33.717129Z","steps":["trace[1050318777] 'process raft request' (duration: 943.4301ms)","trace[1050318777] 'compare' (duration: 15.568489ms)"],"step_count":2} {"level":"warn","ts":"2026-09-08T16:16:33.717348Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T16:16:32.757793Z","time spent":"959.467799ms","remote":"127.0.0.1:52236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-08T16:16:33.717736Z","caller":"traceutil/trace.go:171","msg":"trace[712632435] linearizableReadLoop","detail":"{readStateIndex:15441; appliedIndex:15438; }","duration":"1.329598833s","start":"2026-09-08T16:16:32.38811Z","end":"2026-09-08T16:16:33.717708Z","steps":["trace[712632435] 'read index received' (duration: 1.219670385s)","trace[712632435] 'applied index is now lower than readState.Index' (duration: 109.927358ms)"],"step_count":2} {"level":"info","ts":"2026-09-08T16:16:33.717861Z","caller":"traceutil/trace.go:171","msg":"trace[297591296] transaction","detail":"{read_only:false; response_revision:14917; number_of_response:1; }","duration":"587.444672ms","start":"2026-09-08T16:16:33.130402Z","end":"2026-09-08T16:16:33.717847Z","steps":["trace[297591296] 'process raft request' (duration: 587.094994ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T16:16:33.717773Z","caller":"traceutil/trace.go:171","msg":"trace[1602958321] transaction","detail":"{read_only:false; response_revision:14916; number_of_response:1; }","duration":"954.919595ms","start":"2026-09-08T16:16:32.762834Z","end":"2026-09-08T16:16:33.717753Z","steps":["trace[1602958321] 'process raft request' (duration: 954.229359ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T16:16:33.71812Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.297203179s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-08T16:16:33.718144Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T16:16:33.130378Z","time spent":"587.526714ms","remote":"127.0.0.1:52236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-08T16:16:33.718175Z","caller":"traceutil/trace.go:171","msg":"trace[1379042864] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:14917; }","duration":"1.29727591s","start":"2026-09-08T16:16:32.420881Z","end":"2026-09-08T16:16:33.718157Z","steps":["trace[1379042864] 'agreement among raft nodes before linearized reading' (duration: 1.297205149s)"],"step_count":1} {"level":"warn","ts":"2026-09-08T16:16:33.718214Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T16:16:32.420862Z","time spent":"1.297342263s","remote":"127.0.0.1:51954","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-09-08T16:16:33.718328Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T16:16:32.762806Z","time spent":"955.316454ms","remote":"127.0.0.1:52236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-08T16:16:33.71861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"799.177354ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-09-08T16:16:33.718679Z","caller":"traceutil/trace.go:171","msg":"trace[542628644] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:14917; }","duration":"799.283847ms","start":"2026-09-08T16:16:32.919381Z","end":"2026-09-08T16:16:33.718665Z","steps":["trace[542628644] 'agreement among raft nodes before linearized reading' (duration: 799.137453ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T16:16:33.718466Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.715599ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-08T16:16:33.718792Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T16:16:32.919359Z","time spent":"799.349538ms","remote":"127.0.0.1:52142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12239,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"info","ts":"2026-09-08T16:16:33.718845Z","caller":"traceutil/trace.go:171","msg":"trace[1746085127] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:14917; }","duration":"338.129608ms","start":"2026-09-08T16:16:33.380696Z","end":"2026-09-08T16:16:33.718825Z","steps":["trace[1746085127] 'agreement among raft nodes before linearized reading' (duration: 337.723519ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T16:16:33.719123Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T16:16:33.380677Z","time spent":"338.384874ms","remote":"127.0.0.1:59330","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true "} {"level":"warn","ts":"2026-09-08T16:16:33.718022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.32989167s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/openvswitch-h5x6x\" ","response":"range_response_count:1 size:12364"} {"level":"info","ts":"2026-09-08T16:16:33.719333Z","caller":"traceutil/trace.go:171","msg":"trace[112256817] range","detail":"{range_begin:/registry/pods/openstack/openvswitch-h5x6x; range_end:; response_count:1; response_revision:14917; }","duration":"1.331236391s","start":"2026-09-08T16:16:32.388077Z","end":"2026-09-08T16:16:33.719313Z","steps":["trace[112256817] 'agreement among raft nodes before linearized reading' (duration: 1.329783948s)"],"step_count":1} {"level":"warn","ts":"2026-09-08T16:16:33.719505Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T16:16:32.388062Z","time spent":"1.331424905s","remote":"127.0.0.1:52142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":12387,"request content":"key:\"/registry/pods/openstack/openvswitch-h5x6x\" "} {"level":"info","ts":"2026-09-08T16:16:35.831969Z","caller":"traceutil/trace.go:171","msg":"trace[828484764] transaction","detail":"{read_only:false; response_revision:14935; number_of_response:1; }","duration":"109.788455ms","start":"2026-09-08T16:16:35.722155Z","end":"2026-09-08T16:16:35.831943Z","steps":["trace[828484764] 'process raft request' (duration: 109.58129ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T16:16:35.834815Z","caller":"traceutil/trace.go:171","msg":"trace[1090156670] transaction","detail":"{read_only:false; response_revision:14936; number_of_response:1; }","duration":"111.462924ms","start":"2026-09-08T16:16:35.723329Z","end":"2026-09-08T16:16:35.834792Z","steps":["trace[1090156670] 'process raft request' (duration: 111.29177ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T16:16:35.834981Z","caller":"traceutil/trace.go:171","msg":"trace[1632819615] transaction","detail":"{read_only:false; response_revision:14937; number_of_response:1; }","duration":"111.235249ms","start":"2026-09-08T16:16:35.723719Z","end":"2026-09-08T16:16:35.834954Z","steps":["trace[1632819615] 'process raft request' (duration: 111.020584ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T16:16:44.744401Z","caller":"traceutil/trace.go:171","msg":"trace[1669924547] linearizableReadLoop","detail":"{readStateIndex:15623; appliedIndex:15622; }","duration":"324.208737ms","start":"2026-09-08T16:16:44.420168Z","end":"2026-09-08T16:16:44.744377Z","steps":["trace[1669924547] 'read index received' (duration: 323.988661ms)","trace[1669924547] 'applied index is now lower than readState.Index' (duration: 218.866µs)"],"step_count":2} {"level":"info","ts":"2026-09-08T16:16:44.744588Z","caller":"traceutil/trace.go:171","msg":"trace[1363547664] transaction","detail":"{read_only:false; response_revision:15096; number_of_response:1; }","duration":"360.657196ms","start":"2026-09-08T16:16:44.383797Z","end":"2026-09-08T16:16:44.744455Z","steps":["trace[1363547664] 'process raft request' (duration: 360.367859ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T16:16:44.744586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.400752ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-08T16:16:44.744826Z","caller":"traceutil/trace.go:171","msg":"trace[1005401801] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:15096; }","duration":"324.707529ms","start":"2026-09-08T16:16:44.42007Z","end":"2026-09-08T16:16:44.744777Z","steps":["trace[1005401801] 'agreement among raft nodes before linearized reading' (duration: 324.418642ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T16:16:44.744927Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T16:16:44.420008Z","time spent":"324.884183ms","remote":"127.0.0.1:51954","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-09-08T16:16:44.744869Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T16:16:44.383775Z","time spent":"360.933642ms","remote":"127.0.0.1:52236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-08T16:16:44.766866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.961977ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-9f8b282f-cc6e-41bf-b5e5-2a721b4d50cf\" ","response":"range_response_count:1 size:3607"} {"level":"info","ts":"2026-09-08T16:16:44.766942Z","caller":"traceutil/trace.go:171","msg":"trace[1551514468] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-9f8b282f-cc6e-41bf-b5e5-2a721b4d50cf; range_end:; response_count:1; response_revision:15097; }","duration":"196.08667ms","start":"2026-09-08T16:16:44.570837Z","end":"2026-09-08T16:16:44.766924Z","steps":["trace[1551514468] 'agreement among raft nodes before linearized reading' (duration: 195.875824ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T16:16:44.767046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.424403ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/ovn-controller-default-lddjx.18d364b46a66d634\" ","response":"range_response_count:1 size:783"} {"level":"info","ts":"2026-09-08T16:16:44.767132Z","caller":"traceutil/trace.go:171","msg":"trace[339143285] range","detail":"{range_begin:/registry/events/openstack/ovn-controller-default-lddjx.18d364b46a66d634; range_end:; response_count:1; response_revision:15097; }","duration":"201.564826ms","start":"2026-09-08T16:16:44.565546Z","end":"2026-09-08T16:16:44.76711Z","steps":["trace[339143285] 'agreement among raft nodes before linearized reading' (duration: 201.318231ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T16:16:44.889867Z","caller":"traceutil/trace.go:171","msg":"trace[95025576] transaction","detail":"{read_only:false; response_revision:15100; number_of_response:1; }","duration":"114.518374ms","start":"2026-09-08T16:16:44.775321Z","end":"2026-09-08T16:16:44.889839Z","steps":["trace[95025576] 'process raft request' (duration: 114.450262ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T16:16:44.889881Z","caller":"traceutil/trace.go:171","msg":"trace[734186573] transaction","detail":"{read_only:false; response_revision:15099; number_of_response:1; }","duration":"119.731314ms","start":"2026-09-08T16:16:44.770109Z","end":"2026-09-08T16:16:44.88984Z","steps":["trace[734186573] 'process raft request' (duration: 119.506789ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T16:16:57.956061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.078525ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0\" ","response":"range_response_count:1 size:650"} {"level":"info","ts":"2026-09-08T16:16:57.956148Z","caller":"traceutil/trace.go:171","msg":"trace[1410684132] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0; range_end:; response_count:1; response_revision:15334; }","duration":"104.204478ms","start":"2026-09-08T16:16:57.851923Z","end":"2026-09-08T16:16:57.956128Z","steps":["trace[1410684132] 'agreement among raft nodes before linearized reading' (duration: 104.020934ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T16:16:58.538514Z","caller":"traceutil/trace.go:171","msg":"trace[1019784056] transaction","detail":"{read_only:false; response_revision:15357; number_of_response:1; }","duration":"106.784697ms","start":"2026-09-08T16:16:58.431701Z","end":"2026-09-08T16:16:58.538485Z","steps":["trace[1019784056] 'process raft request' (duration: 79.737845ms)","trace[1019784056] 'get key's previous created_revision and leaseID' {req_type:put; key:/registry/statefulsets/openstack/rabbitmq-nova-server; req_size:9481; } (duration: 26.851378ms)"],"step_count":2} {"level":"warn","ts":"2026-09-08T16:16:58.538716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.67712ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-08T16:16:58.538745Z","caller":"traceutil/trace.go:171","msg":"trace[1578488187] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:15358; }","duration":"118.759572ms","start":"2026-09-08T16:16:58.419979Z","end":"2026-09-08T16:16:58.538739Z","steps":["trace[1578488187] 'agreement among raft nodes before linearized reading' (duration: 118.6717ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T16:16:58.538782Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.020854ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/rabbitmq-nova-nodes\" ","response":"range_response_count:1 size:1245"} {"level":"info","ts":"2026-09-08T16:16:58.538963Z","caller":"traceutil/trace.go:171","msg":"trace[527221986] range","detail":"{range_begin:/registry/services/specs/openstack/rabbitmq-nova-nodes; range_end:; response_count:1; response_revision:15358; }","duration":"118.156198ms","start":"2026-09-08T16:16:58.420719Z","end":"2026-09-08T16:16:58.538875Z","steps":["trace[527221986] 'agreement among raft nodes before linearized reading' (duration: 117.917873ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T16:18:16.609104Z","caller":"traceutil/trace.go:171","msg":"trace[822858609] linearizableReadLoop","detail":"{readStateIndex:16700; appliedIndex:16698; }","duration":"191.023804ms","start":"2026-09-08T16:18:16.418046Z","end":"2026-09-08T16:18:16.60907Z","steps":["trace[822858609] 'read index received' (duration: 65.992148ms)","trace[822858609] 'applied index is now lower than readState.Index' (duration: 125.029946ms)"],"step_count":2} {"level":"info","ts":"2026-09-08T16:18:16.609158Z","caller":"traceutil/trace.go:171","msg":"trace[579175663] transaction","detail":"{read_only:false; response_revision:16143; number_of_response:1; }","duration":"202.268252ms","start":"2026-09-08T16:18:16.406837Z","end":"2026-09-08T16:18:16.609105Z","steps":["trace[579175663] 'process raft request' (duration: 201.964346ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T16:18:16.609318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.25716ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-08T16:18:16.609389Z","caller":"traceutil/trace.go:171","msg":"trace[360931459] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:16143; }","duration":"191.382782ms","start":"2026-09-08T16:18:16.417989Z","end":"2026-09-08T16:18:16.609372Z","steps":["trace[360931459] 'agreement among raft nodes before linearized reading' (duration: 191.26058ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T16:18:16.609417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.604398ms","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-09-08T16:18:16.60947Z","caller":"traceutil/trace.go:171","msg":"trace[2031934576] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:16143; }","duration":"188.70857ms","start":"2026-09-08T16:18:16.420745Z","end":"2026-09-08T16:18:16.609454Z","steps":["trace[2031934576] 'agreement among raft nodes before linearized reading' (duration: 188.518116ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T16:18:16.609687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.187957ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-09-08T16:18:16.609717Z","caller":"traceutil/trace.go:171","msg":"trace[546185791] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:16143; }","duration":"151.27223ms","start":"2026-09-08T16:18:16.458437Z","end":"2026-09-08T16:18:16.609709Z","steps":["trace[546185791] 'agreement among raft nodes before linearized reading' (duration: 151.192408ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T16:18:16.60974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.889314ms","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-09-08T16:18:16.609773Z","caller":"traceutil/trace.go:171","msg":"trace[1537645448] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:16143; }","duration":"161.961945ms","start":"2026-09-08T16:18:16.4478Z","end":"2026-09-08T16:18:16.609762Z","steps":["trace[1537645448] 'agreement among raft nodes before linearized reading' (duration: 161.864373ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T16:18:17.02755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.651491ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-08T16:18:17.027793Z","caller":"traceutil/trace.go:171","msg":"trace[411359355] transaction","detail":"{read_only:false; response_revision:16144; number_of_response:1; }","duration":"413.329438ms","start":"2026-09-08T16:18:16.614436Z","end":"2026-09-08T16:18:17.027765Z","steps":["trace[411359355] 'process raft request' (duration: 187.37431ms)","trace[411359355] 'compare' (duration: 225.386894ms)"],"step_count":2} {"level":"warn","ts":"2026-09-08T16:18:17.027979Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T16:18:16.614425Z","time spent":"413.481491ms","remote":"127.0.0.1:52236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-08T16:18:17.028076Z","caller":"traceutil/trace.go:171","msg":"trace[1460021625] linearizableReadLoop","detail":"{readStateIndex:16703; appliedIndex:16700; }","duration":"382.472939ms","start":"2026-09-08T16:18:16.645455Z","end":"2026-09-08T16:18:17.027928Z","steps":["trace[1460021625] 'read index received' (duration: 156.367157ms)","trace[1460021625] 'applied index is now lower than readState.Index' (duration: 226.104052ms)"],"step_count":2} {"level":"info","ts":"2026-09-08T16:18:17.02782Z","caller":"traceutil/trace.go:171","msg":"trace[1531185754] transaction","detail":"{read_only:false; response_revision:16145; number_of_response:1; }","duration":"412.710934ms","start":"2026-09-08T16:18:16.615091Z","end":"2026-09-08T16:18:17.027802Z","steps":["trace[1531185754] 'process raft request' (duration: 412.598481ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T16:18:17.028243Z","caller":"traceutil/trace.go:171","msg":"trace[345136780] transaction","detail":"{read_only:false; response_revision:16146; number_of_response:1; }","duration":"411.080605ms","start":"2026-09-08T16:18:16.617104Z","end":"2026-09-08T16:18:17.028184Z","steps":["trace[345136780] 'process raft request' (duration: 410.664766ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T16:18:17.028318Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T16:18:16.615063Z","time spent":"413.162114ms","remote":"127.0.0.1:52236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-08T16:18:17.028445Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T16:18:16.617083Z","time spent":"411.286691ms","remote":"127.0.0.1:52236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-08T16:18:17.029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"383.492291ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/certificates/\" range_end:\"/registry/secretgen.k14s.io/certificates0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-08T16:18:17.029052Z","caller":"traceutil/trace.go:171","msg":"trace[385922524] range","detail":"{range_begin:/registry/secretgen.k14s.io/certificates/; range_end:/registry/secretgen.k14s.io/certificates0; response_count:0; response_revision:16146; }","duration":"383.637755ms","start":"2026-09-08T16:18:16.645402Z","end":"2026-09-08T16:18:17.029039Z","steps":["trace[385922524] 'agreement among raft nodes before linearized reading' (duration: 382.765365ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T16:18:17.02909Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T16:18:16.645381Z","time spent":"383.699566ms","remote":"127.0.0.1:55870","response type":"/etcdserverpb.KV/Range","request count":0,"request size":88,"response count":0,"response size":28,"request content":"key:\"/registry/secretgen.k14s.io/certificates/\" range_end:\"/registry/secretgen.k14s.io/certificates0\" count_only:true "} {"level":"info","ts":"2026-09-08T16:20:36.880043Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14568} {"level":"info","ts":"2026-09-08T16:20:36.966552Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14568,"took":"83.506051ms","hash":3923024940,"current-db-size-bytes":56152064,"current-db-size":"56 MB","current-db-size-in-use-bytes":31608832,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-09-08T16:20:36.966601Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3923024940,"revision":14568,"compact-revision":12564} {"level":"info","ts":"2026-09-08T16:24:00.940151Z","caller":"traceutil/trace.go:171","msg":"trace[308226400] transaction","detail":"{read_only:false; response_revision:18590; number_of_response:1; }","duration":"141.103339ms","start":"2026-09-08T16:24:00.799029Z","end":"2026-09-08T16:24:00.940132Z","steps":["trace[308226400] 'process raft request' (duration: 140.840853ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T16:24:03.169023Z","caller":"traceutil/trace.go:171","msg":"trace[111152399] linearizableReadLoop","detail":"{readStateIndex:19237; appliedIndex:19236; }","duration":"193.864577ms","start":"2026-09-08T16:24:02.975125Z","end":"2026-09-08T16:24:03.16899Z","steps":["trace[111152399] 'read index received' (duration: 193.695304ms)","trace[111152399] 'applied index is now lower than readState.Index' (duration: 165.353µs)"],"step_count":2} {"level":"warn","ts":"2026-09-08T16:24:03.169271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.931162ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-kmcxh\" ","response":"range_response_count:1 size:9789"} {"level":"info","ts":"2026-09-08T16:24:03.169315Z","caller":"traceutil/trace.go:171","msg":"trace[1389219957] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-kmcxh; range_end:; response_count:1; response_revision:18599; }","duration":"178.018665ms","start":"2026-09-08T16:24:02.991283Z","end":"2026-09-08T16:24:03.169302Z","steps":["trace[1389219957] 'agreement among raft nodes before linearized reading' (duration: 177.864621ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T16:24:03.169309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.430141ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-09-08T16:24:03.169366Z","caller":"traceutil/trace.go:171","msg":"trace[1153401817] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:18599; }","duration":"163.528503ms","start":"2026-09-08T16:24:03.005823Z","end":"2026-09-08T16:24:03.169351Z","steps":["trace[1153401817] 'agreement among raft nodes before linearized reading' (duration: 163.359079ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T16:24:03.169414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.229876ms","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-09-08T16:24:03.169516Z","caller":"traceutil/trace.go:171","msg":"trace[1242186854] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:18599; }","duration":"194.40814ms","start":"2026-09-08T16:24:02.975083Z","end":"2026-09-08T16:24:03.169492Z","steps":["trace[1242186854] 'agreement among raft nodes before linearized reading' (duration: 194.048712ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T16:24:03.169092Z","caller":"traceutil/trace.go:171","msg":"trace[2058296833] transaction","detail":"{read_only:false; response_revision:18599; number_of_response:1; }","duration":"218.952371ms","start":"2026-09-08T16:24:02.950111Z","end":"2026-09-08T16:24:03.169063Z","steps":["trace[2058296833] 'process raft request' (duration: 218.760737ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T16:24:08.420232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.942853ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-09-08T16:24:08.420351Z","caller":"traceutil/trace.go:171","msg":"trace[1970653211] linearizableReadLoop","detail":"{readStateIndex:19279; appliedIndex:19278; }","duration":"243.145315ms","start":"2026-09-08T16:24:08.177191Z","end":"2026-09-08T16:24:08.420336Z","steps":["trace[1970653211] 'read index received' (duration: 61.591µs)","trace[1970653211] 'applied index is now lower than readState.Index' (duration: 243.082094ms)"],"step_count":2} {"level":"info","ts":"2026-09-08T16:24:08.420465Z","caller":"traceutil/trace.go:171","msg":"trace[1812699290] transaction","detail":"{read_only:false; response_revision:18640; number_of_response:1; }","duration":"420.257099ms","start":"2026-09-08T16:24:08.000192Z","end":"2026-09-08T16:24:08.420449Z","steps":["trace[1812699290] 'process raft request' (duration: 124.025308ms)","trace[1812699290] 'compare' (duration: 295.707498ms)"],"step_count":2} {"level":"warn","ts":"2026-09-08T16:24:08.420538Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T16:24:08.000175Z","time spent":"420.330511ms","remote":"127.0.0.1:52236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-08T16:24:08.420622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.799908ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/neutron-server\" ","response":"range_response_count:1 size:703"} {"level":"info","ts":"2026-09-08T16:24:08.420706Z","caller":"traceutil/trace.go:171","msg":"trace[69927611] range","detail":"{range_begin:/registry/services/endpoints/openstack/neutron-server; range_end:; response_count:1; response_revision:18640; }","duration":"242.90338ms","start":"2026-09-08T16:24:08.177783Z","end":"2026-09-08T16:24:08.420686Z","steps":["trace[69927611] 'agreement among raft nodes before linearized reading' (duration: 242.716346ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T16:24:08.420968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.361536ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-09-08T16:24:08.421012Z","caller":"traceutil/trace.go:171","msg":"trace[2107582982] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:18640; }","duration":"200.438748ms","start":"2026-09-08T16:24:08.22056Z","end":"2026-09-08T16:24:08.420999Z","steps":["trace[2107582982] 'agreement among raft nodes before linearized reading' (duration: 200.332416ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T16:24:08.42114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.952834ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/neutron-server\" ","response":"range_response_count:1 size:703"} {"level":"info","ts":"2026-09-08T16:24:08.421184Z","caller":"traceutil/trace.go:171","msg":"trace[949758358] range","detail":"{range_begin:/registry/services/endpoints/openstack/neutron-server; range_end:; response_count:1; response_revision:18640; }","duration":"244.026975ms","start":"2026-09-08T16:24:08.177144Z","end":"2026-09-08T16:24:08.421171Z","steps":["trace[949758358] 'agreement among raft nodes before linearized reading' (duration: 243.932113ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T16:24:08.421333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.991706ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/neutron-server\" ","response":"range_response_count:1 size:703"} {"level":"info","ts":"2026-09-08T16:24:08.421394Z","caller":"traceutil/trace.go:171","msg":"trace[1634142645] range","detail":"{range_begin:/registry/services/endpoints/openstack/neutron-server; range_end:; response_count:1; response_revision:18640; }","duration":"210.067638ms","start":"2026-09-08T16:24:08.211295Z","end":"2026-09-08T16:24:08.421363Z","steps":["trace[1634142645] 'agreement among raft nodes before linearized reading' (duration: 209.976636ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T16:24:08.564495Z","caller":"traceutil/trace.go:171","msg":"trace[466224319] transaction","detail":"{read_only:false; response_revision:18642; number_of_response:1; }","duration":"122.045984ms","start":"2026-09-08T16:24:08.442423Z","end":"2026-09-08T16:24:08.564469Z","steps":["trace[466224319] 'process raft request' (duration: 121.066792ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T16:25:06.346311Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"548b318b3528a14c","local-member-applied-index":20003,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-09-08T16:25:06.35505Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20003} {"level":"info","ts":"2026-09-08T16:25:06.355143Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15003} {"level":"info","ts":"2026-09-08T16:25:36.886816Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17074} {"level":"info","ts":"2026-09-08T16:25:36.989199Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17074,"took":"99.6084ms","hash":1699435525,"current-db-size-bytes":56152064,"current-db-size":"56 MB","current-db-size-in-use-bytes":34091008,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-09-08T16:25:36.989272Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1699435525,"revision":17074,"compact-revision":14568} {"level":"info","ts":"2026-09-08T16:30:36.894965Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19626} {"level":"info","ts":"2026-09-08T16:30:37.019965Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19626,"took":"119.638744ms","hash":1000229383,"current-db-size-bytes":56152064,"current-db-size":"56 MB","current-db-size-in-use-bytes":29708288,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-09-08T16:30:37.020038Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1000229383,"revision":19626,"compact-revision":17074} {"level":"info","ts":"2026-09-08T16:30:49.724252Z","caller":"traceutil/trace.go:171","msg":"trace[766330211] transaction","detail":"{read_only:false; response_revision:21690; number_of_response:1; }","duration":"140.699985ms","start":"2026-09-08T16:30:49.583525Z","end":"2026-09-08T16:30:49.724225Z","steps":["trace[766330211] 'process raft request' (duration: 140.536891ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T16:30:55.75678Z","caller":"traceutil/trace.go:171","msg":"trace[1889779548] transaction","detail":"{read_only:false; response_revision:21715; number_of_response:1; }","duration":"434.451197ms","start":"2026-09-08T16:30:55.32229Z","end":"2026-09-08T16:30:55.756741Z","steps":["trace[1889779548] 'process raft request' (duration: 434.306013ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T16:30:55.756924Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T16:30:55.322267Z","time spent":"434.584571ms","remote":"127.0.0.1:52236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-08T16:30:55.994351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.792764ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-09-08T16:30:55.994541Z","caller":"traceutil/trace.go:171","msg":"trace[1633144990] transaction","detail":"{read_only:false; response_revision:21716; number_of_response:1; }","duration":"582.94075ms","start":"2026-09-08T16:30:55.411583Z","end":"2026-09-08T16:30:55.994523Z","steps":["trace[1633144990] 'process raft request' (duration: 477.919821ms)","trace[1633144990] 'compare' (duration: 104.673042ms)"],"step_count":2} {"level":"warn","ts":"2026-09-08T16:30:55.994605Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T16:30:55.411553Z","time spent":"583.024722ms","remote":"127.0.0.1:52236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-08T16:30:55.99483Z","caller":"traceutil/trace.go:171","msg":"trace[1088707681] transaction","detail":"{read_only:false; response_revision:21717; number_of_response:1; }","duration":"494.705523ms","start":"2026-09-08T16:30:55.500117Z","end":"2026-09-08T16:30:55.994823Z","steps":["trace[1088707681] 'process raft request' (duration: 494.302714ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T16:30:55.994871Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T16:30:55.500095Z","time spent":"494.755415ms","remote":"127.0.0.1:52236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-08T16:30:56.163598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.113136ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-09-08T16:30:56.163778Z","caller":"traceutil/trace.go:171","msg":"trace[995225607] linearizableReadLoop","detail":"{readStateIndex:22460; appliedIndex:22458; }","duration":"743.675115ms","start":"2026-09-08T16:30:55.42009Z","end":"2026-09-08T16:30:56.163765Z","steps":["trace[995225607] 'read index received' (duration: 336.616812ms)","trace[995225607] 'applied index is now lower than readState.Index' (duration: 407.057553ms)"],"step_count":2} {"level":"warn","ts":"2026-09-08T16:30:56.163866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"743.770297ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-08T16:30:56.163925Z","caller":"traceutil/trace.go:171","msg":"trace[1480398480] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:21717; }","duration":"743.867108ms","start":"2026-09-08T16:30:55.420051Z","end":"2026-09-08T16:30:56.163918Z","steps":["trace[1480398480] 'agreement among raft nodes before linearized reading' (duration: 743.786096ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T16:30:56.163944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T16:30:55.420029Z","time spent":"743.91073ms","remote":"127.0.0.1:51954","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-09-08T16:30:56.16406Z","caller":"traceutil/trace.go:171","msg":"trace[849514448] transaction","detail":"{read_only:false; response_revision:21718; number_of_response:1; }","duration":"162.387601ms","start":"2026-09-08T16:30:56.001641Z","end":"2026-09-08T16:30:56.164029Z","steps":["trace[849514448] 'process raft request' (duration: 162.038213ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T16:30:56.503193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.294184ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-08T16:30:56.503294Z","caller":"traceutil/trace.go:171","msg":"trace[960309708] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:21718; }","duration":"206.446818ms","start":"2026-09-08T16:30:56.296824Z","end":"2026-09-08T16:30:56.50327Z","steps":["trace[960309708] 'count revisions from in-memory index tree' (duration: 206.176702ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T16:30:56.503405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.067351149s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"warn","ts":"2026-09-08T16:30:56.50348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.074480574s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"warn","ts":"2026-09-08T16:30:56.503488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.442103ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-09-08T16:30:56.503547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.051106748s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"warn","ts":"2026-09-08T16:30:56.503592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.055959539s","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-09-08T16:30:56.503492Z","caller":"traceutil/trace.go:171","msg":"trace[281366294] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:21718; }","duration":"1.067494133s","start":"2026-09-08T16:30:55.435976Z","end":"2026-09-08T16:30:56.50347Z","steps":["trace[281366294] 'agreement among raft nodes before linearized reading' (duration: 728.134529ms)","trace[281366294] 'count revisions from in-memory index tree' (duration: 339.234761ms)"],"step_count":2} {"level":"warn","ts":"2026-09-08T16:30:56.503588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"678.914354ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-09-08T16:30:56.503645Z","caller":"traceutil/trace.go:171","msg":"trace[986243342] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:21718; }","duration":"1.051350893s","start":"2026-09-08T16:30:55.452271Z","end":"2026-09-08T16:30:56.503622Z","steps":["trace[986243342] 'agreement among raft nodes before linearized reading' (duration: 711.838055ms)","trace[986243342] 'range keys from in-memory index tree' (duration: 339.265011ms)"],"step_count":2} {"level":"info","ts":"2026-09-08T16:30:56.503656Z","caller":"traceutil/trace.go:171","msg":"trace[395266611] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:21718; }","duration":"1.056047641s","start":"2026-09-08T16:30:55.447587Z","end":"2026-09-08T16:30:56.503635Z","steps":["trace[395266611] 'agreement among raft nodes before linearized reading' (duration: 716.499433ms)","trace[395266611] 'range keys from in-memory index tree' (duration: 339.383115ms)"],"step_count":2} {"level":"info","ts":"2026-09-08T16:30:56.503614Z","caller":"traceutil/trace.go:171","msg":"trace[1591073354] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:21718; }","duration":"338.606317ms","start":"2026-09-08T16:30:56.16498Z","end":"2026-09-08T16:30:56.503587Z","steps":["trace[1591073354] 'range keys from in-memory index tree' (duration: 338.377592ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T16:30:56.503528Z","caller":"traceutil/trace.go:171","msg":"trace[1992083364] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:21718; }","duration":"1.074548484s","start":"2026-09-08T16:30:55.428964Z","end":"2026-09-08T16:30:56.503512Z","steps":["trace[1992083364] 'agreement among raft nodes before linearized reading' (duration: 735.034387ms)","trace[1992083364] 'range keys from in-memory index tree' (duration: 339.373665ms)"],"step_count":2} {"level":"warn","ts":"2026-09-08T16:30:56.503693Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T16:30:55.452256Z","time spent":"1.051425435s","remote":"127.0.0.1:52236","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":464,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-09-08T16:30:56.5037Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T16:30:55.447573Z","time spent":"1.056114962s","remote":"127.0.0.1:52236","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":505,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-09-08T16:30:56.503696Z","caller":"traceutil/trace.go:171","msg":"trace[1949403109] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:21718; }","duration":"679.070177ms","start":"2026-09-08T16:30:55.824595Z","end":"2026-09-08T16:30:56.503665Z","steps":["trace[1949403109] 'agreement among raft nodes before linearized reading' (duration: 339.496938ms)","trace[1949403109] 'count revisions from in-memory index tree' (duration: 339.411526ms)"],"step_count":2} {"level":"warn","ts":"2026-09-08T16:30:56.503708Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T16:30:56.164966Z","time spent":"338.72808ms","remote":"127.0.0.1:51970","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-09-08T16:30:56.503714Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T16:30:55.428952Z","time spent":"1.074746279s","remote":"127.0.0.1:52236","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":532,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-09-08T16:30:56.50379Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T16:30:55.824579Z","time spent":"679.16259ms","remote":"127.0.0.1:59346","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":1,"response size":31,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"warn","ts":"2026-09-08T16:30:56.504143Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T16:30:55.435954Z","time spent":"1.067700738s","remote":"127.0.0.1:36062","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":31,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "} {"level":"warn","ts":"2026-09-08T16:30:56.504399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.05427425s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-09-08T16:30:56.504475Z","caller":"traceutil/trace.go:171","msg":"trace[1162623299] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:21718; }","duration":"1.054375343s","start":"2026-09-08T16:30:55.450077Z","end":"2026-09-08T16:30:56.504452Z","steps":["trace[1162623299] 'agreement among raft nodes before linearized reading' (duration: 713.945375ms)","trace[1162623299] 'range keys from in-memory index tree' (duration: 340.140841ms)"],"step_count":2} {"level":"warn","ts":"2026-09-08T16:30:56.504518Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T16:30:55.450063Z","time spent":"1.054443014s","remote":"127.0.0.1:52236","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-09-08T16:30:56.746849Z","caller":"traceutil/trace.go:171","msg":"trace[1009351085] linearizableReadLoop","detail":"{readStateIndex:22467; appliedIndex:22463; }","duration":"234.630891ms","start":"2026-09-08T16:30:56.512192Z","end":"2026-09-08T16:30:56.746823Z","steps":["trace[1009351085] 'read index received' (duration: 42.46381ms)","trace[1009351085] 'applied index is now lower than readState.Index' (duration: 192.166091ms)"],"step_count":2} {"level":"info","ts":"2026-09-08T16:30:56.746929Z","caller":"traceutil/trace.go:171","msg":"trace[651699320] transaction","detail":"{read_only:false; response_revision:21722; number_of_response:1; }","duration":"236.075044ms","start":"2026-09-08T16:30:56.510825Z","end":"2026-09-08T16:30:56.7469Z","steps":["trace[651699320] 'process raft request' (duration: 235.965471ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T16:30:56.74698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.763024ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-08T16:30:56.746921Z","caller":"traceutil/trace.go:171","msg":"trace[1253118283] transaction","detail":"{read_only:false; response_revision:21720; number_of_response:1; }","duration":"237.098167ms","start":"2026-09-08T16:30:56.509783Z","end":"2026-09-08T16:30:56.746881Z","steps":["trace[1253118283] 'process raft request' (duration: 236.792831ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T16:30:56.747049Z","caller":"traceutil/trace.go:171","msg":"trace[580910257] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:21722; }","duration":"234.852346ms","start":"2026-09-08T16:30:56.512186Z","end":"2026-09-08T16:30:56.747038Z","steps":["trace[580910257] 'agreement among raft nodes before linearized reading' (duration: 234.738633ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T16:30:56.747128Z","caller":"traceutil/trace.go:171","msg":"trace[29137110] transaction","detail":"{read_only:false; response_revision:21721; number_of_response:1; }","duration":"236.900523ms","start":"2026-09-08T16:30:56.509956Z","end":"2026-09-08T16:30:56.746857Z","steps":["trace[29137110] 'process raft request' (duration: 236.777ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T16:32:12.484779Z","caller":"traceutil/trace.go:171","msg":"trace[122803834] transaction","detail":"{read_only:false; response_revision:22396; number_of_response:1; }","duration":"113.622226ms","start":"2026-09-08T16:32:12.371133Z","end":"2026-09-08T16:32:12.484756Z","steps":["trace[122803834] 'process raft request' (duration: 55.513048ms)","trace[122803834] 'compare' (duration: 57.451933ms)"],"step_count":2} {"level":"info","ts":"2026-09-08T16:35:03.416353Z","caller":"traceutil/trace.go:171","msg":"trace[513409945] transaction","detail":"{read_only:false; response_revision:24155; number_of_response:1; }","duration":"201.842162ms","start":"2026-09-08T16:35:03.214486Z","end":"2026-09-08T16:35:03.416328Z","steps":["trace[513409945] 'process raft request' (duration: 201.654577ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T16:35:03.757751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.189334ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-09-08T16:35:03.757918Z","caller":"traceutil/trace.go:171","msg":"trace[2075417964] linearizableReadLoop","detail":"{readStateIndex:24976; appliedIndex:24975; }","duration":"522.303345ms","start":"2026-09-08T16:35:03.235592Z","end":"2026-09-08T16:35:03.757896Z","steps":["trace[2075417964] 'read index received' (duration: 180.730421ms)","trace[2075417964] 'applied index is now lower than readState.Index' (duration: 341.570804ms)"],"step_count":2} {"level":"info","ts":"2026-09-08T16:35:03.757958Z","caller":"traceutil/trace.go:171","msg":"trace[1920436048] transaction","detail":"{read_only:false; response_revision:24156; number_of_response:1; }","duration":"526.665264ms","start":"2026-09-08T16:35:03.231255Z","end":"2026-09-08T16:35:03.757921Z","steps":["trace[1920436048] 'process raft request' (duration: 277.159693ms)","trace[1920436048] 'compare' (duration: 248.312853ms)"],"step_count":2} {"level":"warn","ts":"2026-09-08T16:35:03.758086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"522.486479ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackmachines/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackmachines0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-08T16:35:03.758128Z","caller":"traceutil/trace.go:171","msg":"trace[1422001021] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackmachines/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackmachines0; response_count:0; response_revision:24156; }","duration":"522.563461ms","start":"2026-09-08T16:35:03.235552Z","end":"2026-09-08T16:35:03.758116Z","steps":["trace[1422001021] 'agreement among raft nodes before linearized reading' (duration: 522.468259ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T16:35:03.758138Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T16:35:03.231234Z","time spent":"526.807938ms","remote":"127.0.0.1:52236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-08T16:35:03.758172Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T16:35:03.23554Z","time spent":"522.620692ms","remote":"127.0.0.1:41910","response type":"/etcdserverpb.KV/Range","request count":0,"request size":126,"response count":0,"response size":29,"request content":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackmachines/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackmachines0\" count_only:true "} {"level":"warn","ts":"2026-09-08T16:35:03.758415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"522.648472ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackmachines/cert-manager-test/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackmachines/cert-manager-test0\" limit:10000 ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-08T16:35:03.758473Z","caller":"traceutil/trace.go:171","msg":"trace[497602557] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackmachines/cert-manager-test/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackmachines/cert-manager-test0; response_count:0; response_revision:24156; }","duration":"522.735444ms","start":"2026-09-08T16:35:03.235724Z","end":"2026-09-08T16:35:03.75846Z","steps":["trace[497602557] 'agreement among raft nodes before linearized reading' (duration: 522.636052ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T16:35:03.758507Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T16:35:03.235717Z","time spent":"522.779105ms","remote":"127.0.0.1:41910","response type":"/etcdserverpb.KV/Range","request count":0,"request size":163,"response count":0,"response size":29,"request content":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackmachines/cert-manager-test/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackmachines/cert-manager-test0\" limit:10000 "} {"level":"warn","ts":"2026-09-08T16:35:03.758519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"461.663129ms","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":"warn","ts":"2026-09-08T16:35:03.75858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"522.771055ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackmachines/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackmachines0\" limit:10000 ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-08T16:35:03.758659Z","caller":"traceutil/trace.go:171","msg":"trace[483499781] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackmachines/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackmachines0; response_count:0; response_revision:24156; }","duration":"523.085163ms","start":"2026-09-08T16:35:03.235555Z","end":"2026-09-08T16:35:03.758641Z","steps":["trace[483499781] 'agreement among raft nodes before linearized reading' (duration: 522.93642ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T16:35:03.758678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.504591ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-09-08T16:35:03.758701Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T16:35:03.235543Z","time spent":"523.147894ms","remote":"127.0.0.1:41910","response type":"/etcdserverpb.KV/Range","request count":0,"request size":127,"response count":0,"response size":29,"request content":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackmachines/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackmachines0\" limit:10000 "} {"level":"info","ts":"2026-09-08T16:35:03.758738Z","caller":"traceutil/trace.go:171","msg":"trace[1309276361] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24156; }","duration":"337.612684ms","start":"2026-09-08T16:35:03.421108Z","end":"2026-09-08T16:35:03.758721Z","steps":["trace[1309276361] 'agreement among raft nodes before linearized reading' (duration: 337.504841ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T16:35:03.758506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"461.390883ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-08T16:35:03.75884Z","caller":"traceutil/trace.go:171","msg":"trace[1121483877] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:24156; }","duration":"461.72745ms","start":"2026-09-08T16:35:03.297064Z","end":"2026-09-08T16:35:03.758791Z","steps":["trace[1121483877] 'agreement among raft nodes before linearized reading' (duration: 461.332882ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T16:35:03.759104Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T16:35:03.297055Z","time spent":"461.935245ms","remote":"127.0.0.1:52284","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":29,"request content":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true "} {"level":"info","ts":"2026-09-08T16:35:03.758741Z","caller":"traceutil/trace.go:171","msg":"trace[153290895] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/; range_end:/registry/rabbitmq.com/rabbitmqclusters0; response_count:0; response_revision:24156; }","duration":"461.777792ms","start":"2026-09-08T16:35:03.296796Z","end":"2026-09-08T16:35:03.758574Z","steps":["trace[153290895] 'agreement among raft nodes before linearized reading' (duration: 461.654279ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T16:35:03.759413Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T16:35:03.296771Z","time spent":"462.59161ms","remote":"127.0.0.1:35912","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":9,"response size":31,"request content":"key:\"/registry/rabbitmq.com/rabbitmqclusters/\" range_end:\"/registry/rabbitmq.com/rabbitmqclusters0\" count_only:true "} {"level":"warn","ts":"2026-09-08T16:35:03.758794Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T16:35:03.421091Z","time spent":"337.690465ms","remote":"127.0.0.1:51954","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-09-08T16:35:04.212605Z","caller":"traceutil/trace.go:171","msg":"trace[386387581] linearizableReadLoop","detail":"{readStateIndex:24977; appliedIndex:24977; }","duration":"417.434188ms","start":"2026-09-08T16:35:03.795133Z","end":"2026-09-08T16:35:04.212568Z","steps":["trace[386387581] 'read index received' (duration: 417.346916ms)","trace[386387581] 'applied index is now lower than readState.Index' (duration: 21.151µs)"],"step_count":2} {"level":"warn","ts":"2026-09-08T16:35:04.212726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"417.653663ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackfloatingippools/cert-manager-test/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackfloatingippools/cert-manager-test0\" limit:10000 ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-08T16:35:04.21277Z","caller":"traceutil/trace.go:171","msg":"trace[1888628313] transaction","detail":"{read_only:false; response_revision:24157; number_of_response:1; }","duration":"418.016801ms","start":"2026-09-08T16:35:03.794729Z","end":"2026-09-08T16:35:04.212745Z","steps":["trace[1888628313] 'process raft request' (duration: 417.51133ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T16:35:04.212828Z","caller":"traceutil/trace.go:171","msg":"trace[140634380] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackfloatingippools/cert-manager-test/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackfloatingippools/cert-manager-test0; response_count:0; response_revision:24157; }","duration":"417.818397ms","start":"2026-09-08T16:35:03.79499Z","end":"2026-09-08T16:35:04.212809Z","steps":["trace[140634380] 'agreement among raft nodes before linearized reading' (duration: 417.629423ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T16:35:04.212885Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T16:35:03.794981Z","time spent":"417.891128ms","remote":"127.0.0.1:41912","response type":"/etcdserverpb.KV/Range","request count":0,"request size":177,"response count":0,"response size":29,"request content":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackfloatingippools/cert-manager-test/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackfloatingippools/cert-manager-test0\" limit:10000 "} {"level":"warn","ts":"2026-09-08T16:35:04.212899Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T16:35:03.794713Z","time spent":"418.116053ms","remote":"127.0.0.1:52142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5372,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-08T16:35:04.216565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.663625ms","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-09-08T16:35:04.216649Z","caller":"traceutil/trace.go:171","msg":"trace[1678934060] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:24158; }","duration":"368.791788ms","start":"2026-09-08T16:35:03.847832Z","end":"2026-09-08T16:35:04.216624Z","steps":["trace[1678934060] 'agreement among raft nodes before linearized reading' (duration: 368.648585ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T16:35:04.216684Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T16:35:03.847806Z","time spent":"368.869729ms","remote":"127.0.0.1:52398","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":29,"request content":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" "} {"level":"warn","ts":"2026-09-08T16:35:04.21672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.790292ms","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-09-08T16:35:04.216784Z","caller":"traceutil/trace.go:171","msg":"trace[1365453763] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24158; }","duration":"303.911885ms","start":"2026-09-08T16:35:03.912854Z","end":"2026-09-08T16:35:04.216766Z","steps":["trace[1365453763] 'agreement among raft nodes before linearized reading' (duration: 303.722781ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T16:35:04.216793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.755145ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"warn","ts":"2026-09-08T16:35:04.216832Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T16:35:03.912829Z","time spent":"303.991197ms","remote":"127.0.0.1:52236","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":505,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-09-08T16:35:04.216895Z","caller":"traceutil/trace.go:171","msg":"trace[203914996] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24158; }","duration":"178.917988ms","start":"2026-09-08T16:35:04.037953Z","end":"2026-09-08T16:35:04.216871Z","steps":["trace[203914996] 'agreement among raft nodes before linearized reading' (duration: 178.597001ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T16:35:04.21704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.85584ms","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-09-08T16:35:04.217057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.187724ms","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-09-08T16:35:04.217087Z","caller":"traceutil/trace.go:171","msg":"trace[68588833] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24158; }","duration":"109.900431ms","start":"2026-09-08T16:35:04.107172Z","end":"2026-09-08T16:35:04.217072Z","steps":["trace[68588833] 'agreement among raft nodes before linearized reading' (duration: 109.335778ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T16:35:04.217135Z","caller":"traceutil/trace.go:171","msg":"trace[896192716] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24158; }","duration":"133.301647ms","start":"2026-09-08T16:35:04.083811Z","end":"2026-09-08T16:35:04.217113Z","steps":["trace[896192716] 'agreement among raft nodes before linearized reading' (duration: 133.120033ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T16:35:36.906928Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":21622} {"level":"info","ts":"2026-09-08T16:35:37.021753Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":21622,"took":"110.670468ms","hash":660700700,"current-db-size-bytes":56152064,"current-db-size":"56 MB","current-db-size-in-use-bytes":42565632,"current-db-size-in-use":"43 MB"} {"level":"info","ts":"2026-09-08T16:35:37.021843Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":660700700,"revision":21622,"compact-revision":19626} {"level":"info","ts":"2026-09-08T16:40:36.913667Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":24594} {"level":"info","ts":"2026-09-08T16:40:37.067989Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":24594,"took":"150.649742ms","hash":3857854430,"current-db-size-bytes":56152064,"current-db-size":"56 MB","current-db-size-in-use-bytes":32481280,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-09-08T16:40:37.068066Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3857854430,"revision":24594,"compact-revision":21622} {"level":"info","ts":"2026-09-08T16:40:49.777542Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-0000000000006d61.wal"} {"level":"info","ts":"2026-09-08T16:45:11.639592Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"548b318b3528a14c","local-member-applied-index":30004,"local-member-snapshot-index":20003,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-09-08T16:45:11.644746Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30004} {"level":"info","ts":"2026-09-08T16:45:11.644853Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25004}