{"level":"warn","ts":"2026-06-15T11:49:03.458855Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-15T11:49:03.45898Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.104:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.104:2380","--initial-cluster=instance=https://199.19.213.104:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.104:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.104:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-06-15T11:49:03.459073Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-15T11:49:03.459104Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.104:2380"]} {"level":"info","ts":"2026-06-15T11:49:03.459128Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-06-15T11:49:03.459967Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.104:2379"]} {"level":"info","ts":"2026-06-15T11:49:03.460066Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.104:2380"],"listen-peer-urls":["https://199.19.213.104:2380"],"advertise-client-urls":["https://199.19.213.104:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.104:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.104:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-06-15T11:49:03.464262Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.884951ms"} {"level":"info","ts":"2026-06-15T11:49:03.473604Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"8a0c9a032e61a05a","cluster-id":"153e4a99345578f6"} {"level":"info","ts":"2026-06-15T11:49:03.47376Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8a0c9a032e61a05a switched to configuration voters=()"} {"level":"info","ts":"2026-06-15T11:49:03.473802Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8a0c9a032e61a05a became follower at term 0"} {"level":"info","ts":"2026-06-15T11:49:03.473814Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 8a0c9a032e61a05a [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-15T11:49:03.473823Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8a0c9a032e61a05a became follower at term 1"} {"level":"info","ts":"2026-06-15T11:49:03.473906Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8a0c9a032e61a05a switched to configuration voters=(9947495015408312410)"} {"level":"warn","ts":"2026-06-15T11:49:03.487229Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-15T11:49:03.491188Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-15T11:49:03.493339Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-06-15T11:49:03.496815Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"8a0c9a032e61a05a","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-15T11:49:03.496967Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"8a0c9a032e61a05a","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-15T11:49:03.497156Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-15T11:49:03.497214Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-15T11:49:03.497225Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-15T11:49:03.498139Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8a0c9a032e61a05a switched to configuration voters=(9947495015408312410)"} {"level":"info","ts":"2026-06-15T11:49:03.502009Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"153e4a99345578f6","local-member-id":"8a0c9a032e61a05a","added-peer-id":"8a0c9a032e61a05a","added-peer-peer-urls":["https://199.19.213.104:2380"]} {"level":"info","ts":"2026-06-15T11:49:03.504078Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-06-15T11:49:03.504246Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.104:2380"} {"level":"info","ts":"2026-06-15T11:49:03.504286Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.104:2380"} {"level":"info","ts":"2026-06-15T11:49:03.504573Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"8a0c9a032e61a05a","initial-advertise-peer-urls":["https://199.19.213.104:2380"],"listen-peer-urls":["https://199.19.213.104:2380"],"advertise-client-urls":["https://199.19.213.104:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.104:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-15T11:49:03.50464Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-15T11:49:04.175082Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8a0c9a032e61a05a is starting a new election at term 1"} {"level":"info","ts":"2026-06-15T11:49:04.175172Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8a0c9a032e61a05a became pre-candidate at term 1"} {"level":"info","ts":"2026-06-15T11:49:04.175203Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8a0c9a032e61a05a received MsgPreVoteResp from 8a0c9a032e61a05a at term 1"} {"level":"info","ts":"2026-06-15T11:49:04.175223Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8a0c9a032e61a05a became candidate at term 2"} {"level":"info","ts":"2026-06-15T11:49:04.175239Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8a0c9a032e61a05a received MsgVoteResp from 8a0c9a032e61a05a at term 2"} {"level":"info","ts":"2026-06-15T11:49:04.175256Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8a0c9a032e61a05a became leader at term 2"} {"level":"info","ts":"2026-06-15T11:49:04.17527Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 8a0c9a032e61a05a elected leader 8a0c9a032e61a05a at term 2"} {"level":"info","ts":"2026-06-15T11:49:04.176528Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"8a0c9a032e61a05a","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.104:2379]}","request-path":"/0/members/8a0c9a032e61a05a/attributes","cluster-id":"153e4a99345578f6","publish-timeout":"7s"} {"level":"info","ts":"2026-06-15T11:49:04.17658Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-15T11:49:04.176603Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-15T11:49:04.176872Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-15T11:49:04.176925Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-15T11:49:04.177042Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-15T11:49:04.179013Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-15T11:49:04.18093Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.104:2379"} {"level":"info","ts":"2026-06-15T11:49:04.181943Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"153e4a99345578f6","local-member-id":"8a0c9a032e61a05a","cluster-version":"3.5"} {"level":"info","ts":"2026-06-15T11:49:04.182087Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-15T11:49:04.182128Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"warn","ts":"2026-06-15T11:49:15.378389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.107393ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-proxy-mhvgq\" ","response":"range_response_count:1 size:4466"} {"level":"info","ts":"2026-06-15T11:49:15.378546Z","caller":"traceutil/trace.go:171","msg":"trace[1549287761] range","detail":"{range_begin:/registry/pods/kube-system/kube-proxy-mhvgq; range_end:; response_count:1; response_revision:390; }","duration":"235.304038ms","start":"2026-06-15T11:49:15.143214Z","end":"2026-06-15T11:49:15.378518Z","steps":["trace[1549287761] 'range keys from in-memory index tree' (duration: 235.012661ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:49:15.564534Z","caller":"traceutil/trace.go:171","msg":"trace[1989284541] transaction","detail":"{read_only:false; response_revision:391; number_of_response:1; }","duration":"181.44726ms","start":"2026-06-15T11:49:15.383059Z","end":"2026-06-15T11:49:15.564506Z","steps":["trace[1989284541] 'process raft request' (duration: 181.226915ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:49:15.754767Z","caller":"traceutil/trace.go:171","msg":"trace[153135555] linearizableReadLoop","detail":"{readStateIndex:405; appliedIndex:404; }","duration":"162.847855ms","start":"2026-06-15T11:49:15.591895Z","end":"2026-06-15T11:49:15.754743Z","steps":["trace[153135555] 'read index received' (duration: 162.576168ms)","trace[153135555] 'applied index is now lower than readState.Index' (duration: 270.696µs)"],"step_count":2} {"level":"info","ts":"2026-06-15T11:49:15.754852Z","caller":"traceutil/trace.go:171","msg":"trace[1215626487] transaction","detail":"{read_only:false; response_revision:392; number_of_response:1; }","duration":"367.433175ms","start":"2026-06-15T11:49:15.387382Z","end":"2026-06-15T11:49:15.754815Z","steps":["trace[1215626487] 'process raft request' (duration: 367.21982ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:49:15.755019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.109451ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-15T11:49:15.755187Z","caller":"traceutil/trace.go:171","msg":"trace[1567844479] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:392; }","duration":"163.319066ms","start":"2026-06-15T11:49:15.591837Z","end":"2026-06-15T11:49:15.755156Z","steps":["trace[1567844479] 'agreement among raft nodes before linearized reading' (duration: 163.032829ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:49:15.755683Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T11:49:15.387345Z","time spent":"367.599929ms","remote":"127.0.0.1:41438","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4467,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T11:49:15.888871Z","caller":"traceutil/trace.go:171","msg":"trace[2014281013] transaction","detail":"{read_only:false; response_revision:393; number_of_response:1; }","duration":"128.348369ms","start":"2026-06-15T11:49:15.760496Z","end":"2026-06-15T11:49:15.888844Z","steps":["trace[2014281013] 'process raft request' (duration: 32.128541ms)","trace[2014281013] 'compare' (duration: 96.082645ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T11:49:15.889386Z","caller":"traceutil/trace.go:171","msg":"trace[1679788941] transaction","detail":"{read_only:false; response_revision:395; number_of_response:1; }","duration":"120.718201ms","start":"2026-06-15T11:49:15.768645Z","end":"2026-06-15T11:49:15.889363Z","steps":["trace[1679788941] 'process raft request' (duration: 120.6666ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:49:15.889501Z","caller":"traceutil/trace.go:171","msg":"trace[27073722] transaction","detail":"{read_only:false; response_revision:394; number_of_response:1; }","duration":"127.10301ms","start":"2026-06-15T11:49:15.762373Z","end":"2026-06-15T11:49:15.889476Z","steps":["trace[27073722] 'process raft request' (duration: 126.705281ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:49:43.68613Z","caller":"traceutil/trace.go:171","msg":"trace[1491850747] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"120.405726ms","start":"2026-06-15T11:49:43.56569Z","end":"2026-06-15T11:49:43.686095Z","steps":["trace[1491850747] 'process raft request' (duration: 120.031697ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:49:43.6862Z","caller":"traceutil/trace.go:171","msg":"trace[1805643631] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"117.454546ms","start":"2026-06-15T11:49:43.568723Z","end":"2026-06-15T11:49:43.686177Z","steps":["trace[1805643631] 'process raft request' (duration: 117.126078ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:49:43.6863Z","caller":"traceutil/trace.go:171","msg":"trace[1922862939] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"102.882819ms","start":"2026-06-15T11:49:43.583396Z","end":"2026-06-15T11:49:43.686279Z","steps":["trace[1922862939] 'process raft request' (duration: 102.581552ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:49:44.045207Z","caller":"traceutil/trace.go:171","msg":"trace[1780507020] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"351.035104ms","start":"2026-06-15T11:49:43.694144Z","end":"2026-06-15T11:49:44.045179Z","steps":["trace[1780507020] 'process raft request' (duration: 349.655981ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:49:44.045358Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T11:49:43.694131Z","time spent":"351.163567ms","remote":"127.0.0.1:41804","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":986,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-15T11:49:44.049978Z","caller":"traceutil/trace.go:171","msg":"trace[1404839031] transaction","detail":"{read_only:false; number_of_response:1; response_revision:578; }","duration":"343.049314ms","start":"2026-06-15T11:49:43.706765Z","end":"2026-06-15T11:49:44.049814Z","steps":["trace[1404839031] 'process raft request' (duration: 342.579603ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:49:44.050581Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T11:49:43.706741Z","time spent":"343.668229ms","remote":"127.0.0.1:41298","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":97,"response count":0,"response size":150531,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T11:49:44.052792Z","caller":"traceutil/trace.go:171","msg":"trace[1528837870] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"286.506409ms","start":"2026-06-15T11:49:43.766211Z","end":"2026-06-15T11:49:44.052718Z","steps":["trace[1528837870] 'process raft request' (duration: 283.570319ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:49:44.053902Z","caller":"traceutil/trace.go:171","msg":"trace[1765848400] linearizableReadLoop","detail":"{readStateIndex:601; appliedIndex:599; }","duration":"341.262781ms","start":"2026-06-15T11:49:43.712558Z","end":"2026-06-15T11:49:44.053821Z","steps":["trace[1765848400] 'read index received' (duration: 331.414847ms)","trace[1765848400] 'applied index is now lower than readState.Index' (duration: 9.828604ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T11:49:44.054249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.656952ms","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-06-15T11:49:44.054429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.165814ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T11:49:44.054448Z","caller":"traceutil/trace.go:171","msg":"trace[1950368598] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:580; }","duration":"341.806154ms","start":"2026-06-15T11:49:43.712522Z","end":"2026-06-15T11:49:44.054328Z","steps":["trace[1950368598] 'agreement among raft nodes before linearized reading' (duration: 341.525948ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:49:44.054447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.185086ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-15T11:49:44.054487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.983288ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T11:49:44.054526Z","caller":"traceutil/trace.go:171","msg":"trace[378645997] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:580; }","duration":"321.292746ms","start":"2026-06-15T11:49:43.733194Z","end":"2026-06-15T11:49:44.054487Z","steps":["trace[378645997] 'agreement among raft nodes before linearized reading' (duration: 321.096522ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:49:44.054506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.971818ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-15T11:49:44.054544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.47417ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-15T11:49:44.054572Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T11:49:43.733176Z","time spent":"321.383739ms","remote":"127.0.0.1:37276","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"warn","ts":"2026-06-15T11:49:44.054562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.392371ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T11:49:44.054613Z","caller":"traceutil/trace.go:171","msg":"trace[82031065] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:580; }","duration":"289.094381ms","start":"2026-06-15T11:49:43.765476Z","end":"2026-06-15T11:49:44.054571Z","steps":["trace[82031065] 'agreement among raft nodes before linearized reading' (duration: 288.940668ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:49:44.05455Z","caller":"traceutil/trace.go:171","msg":"trace[1263294114] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:580; }","duration":"195.293699ms","start":"2026-06-15T11:49:43.859216Z","end":"2026-06-15T11:49:44.054509Z","steps":["trace[1263294114] 'agreement among raft nodes before linearized reading' (duration: 195.059463ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:49:44.054622Z","caller":"traceutil/trace.go:171","msg":"trace[1834352634] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:580; }","duration":"210.548682ms","start":"2026-06-15T11:49:43.844041Z","end":"2026-06-15T11:49:44.05459Z","steps":["trace[1834352634] 'agreement among raft nodes before linearized reading' (duration: 210.45754ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:49:44.054702Z","caller":"traceutil/trace.go:171","msg":"trace[1307658058] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:580; }","duration":"195.561054ms","start":"2026-06-15T11:49:43.859102Z","end":"2026-06-15T11:49:44.054663Z","steps":["trace[1307658058] 'agreement among raft nodes before linearized reading' (duration: 195.233677ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:49:44.054679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.483496ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-15T11:49:44.054684Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T11:49:43.712502Z","time spent":"341.99946ms","remote":"127.0.0.1:41510","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-06-15T11:49:44.054485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.905332ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-15T11:49:44.055003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.291586ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T11:49:44.055087Z","caller":"traceutil/trace.go:171","msg":"trace[1547276441] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:580; }","duration":"321.830719ms","start":"2026-06-15T11:49:43.733241Z","end":"2026-06-15T11:49:44.055072Z","steps":["trace[1547276441] 'agreement among raft nodes before linearized reading' (duration: 321.215785ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:49:44.055062Z","caller":"traceutil/trace.go:171","msg":"trace[1042332617] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:580; }","duration":"235.523876ms","start":"2026-06-15T11:49:43.819484Z","end":"2026-06-15T11:49:44.055008Z","steps":["trace[1042332617] 'agreement among raft nodes before linearized reading' (duration: 234.795688ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:49:44.054841Z","caller":"traceutil/trace.go:171","msg":"trace[246363205] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:580; }","duration":"288.837565ms","start":"2026-06-15T11:49:43.765932Z","end":"2026-06-15T11:49:44.054769Z","steps":["trace[246363205] 'agreement among raft nodes before linearized reading' (duration: 288.368794ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:49:44.055142Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T11:49:43.73322Z","time spent":"321.908422ms","remote":"127.0.0.1:37276","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 "} {"level":"info","ts":"2026-06-15T11:49:44.054597Z","caller":"traceutil/trace.go:171","msg":"trace[1016300784] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:580; }","duration":"289.119922ms","start":"2026-06-15T11:49:43.765436Z","end":"2026-06-15T11:49:44.054556Z","steps":["trace[1016300784] 'agreement among raft nodes before linearized reading' (duration: 288.876776ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:49:44.054423Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.833168ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T11:49:44.055305Z","caller":"traceutil/trace.go:171","msg":"trace[1464891587] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:580; }","duration":"211.73687ms","start":"2026-06-15T11:49:43.843548Z","end":"2026-06-15T11:49:44.055285Z","steps":["trace[1464891587] 'agreement among raft nodes before linearized reading' (duration: 210.758247ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:49:44.05536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.35728ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T11:49:44.056418Z","caller":"traceutil/trace.go:171","msg":"trace[1665895169] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:580; }","duration":"196.673421ms","start":"2026-06-15T11:49:43.859714Z","end":"2026-06-15T11:49:44.056387Z","steps":["trace[1665895169] 'agreement among raft nodes before linearized reading' (duration: 194.93128ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:49:44.056438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.354287ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-15T11:49:44.056466Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.921408ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T11:49:44.05648Z","caller":"traceutil/trace.go:171","msg":"trace[353348571] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:580; }","duration":"260.449709ms","start":"2026-06-15T11:49:43.796017Z","end":"2026-06-15T11:49:44.056467Z","steps":["trace[353348571] 'agreement among raft nodes before linearized reading' (duration: 258.608006ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:49:44.056507Z","caller":"traceutil/trace.go:171","msg":"trace[2002628865] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:580; }","duration":"212.9893ms","start":"2026-06-15T11:49:43.843505Z","end":"2026-06-15T11:49:44.056494Z","steps":["trace[2002628865] 'agreement among raft nodes before linearized reading' (duration: 211.136476ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:49:44.056549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.209393ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T11:49:44.056604Z","caller":"traceutil/trace.go:171","msg":"trace[274401520] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:580; }","duration":"236.284804ms","start":"2026-06-15T11:49:43.820302Z","end":"2026-06-15T11:49:44.056586Z","steps":["trace[274401520] 'agreement among raft nodes before linearized reading' (duration: 234.322508ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:49:44.056699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.003838ms","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:5"} {"level":"info","ts":"2026-06-15T11:49:44.056727Z","caller":"traceutil/trace.go:171","msg":"trace[715949401] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:580; }","duration":"152.10405ms","start":"2026-06-15T11:49:43.904615Z","end":"2026-06-15T11:49:44.056719Z","steps":["trace[715949401] 'agreement among raft nodes before linearized reading' (duration: 150.015701ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:49:44.056736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.318307ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T11:49:44.056761Z","caller":"traceutil/trace.go:171","msg":"trace[1814092099] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:580; }","duration":"126.342147ms","start":"2026-06-15T11:49:43.93041Z","end":"2026-06-15T11:49:44.056753Z","steps":["trace[1814092099] 'agreement among raft nodes before linearized reading' (duration: 124.587645ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:49:44.056702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.369009ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T11:49:44.056848Z","caller":"traceutil/trace.go:171","msg":"trace[1125366842] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:580; }","duration":"171.552653ms","start":"2026-06-15T11:49:43.88528Z","end":"2026-06-15T11:49:44.056833Z","steps":["trace[1125366842] 'agreement among raft nodes before linearized reading' (duration: 169.441013ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:49:44.056892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.125653ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-15T11:49:44.056893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.183175ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T11:49:44.056934Z","caller":"traceutil/trace.go:171","msg":"trace[1438750603] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:580; }","duration":"108.189655ms","start":"2026-06-15T11:49:43.948731Z","end":"2026-06-15T11:49:44.056921Z","steps":["trace[1438750603] 'agreement among raft nodes before linearized reading' (duration: 105.902951ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:49:44.056955Z","caller":"traceutil/trace.go:171","msg":"trace[425624033] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:580; }","duration":"108.287297ms","start":"2026-06-15T11:49:43.948648Z","end":"2026-06-15T11:49:44.056935Z","steps":["trace[425624033] 'agreement among raft nodes before linearized reading' (duration: 105.976383ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:49:44.057012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.106551ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T11:49:44.057059Z","caller":"traceutil/trace.go:171","msg":"trace[1007359506] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:580; }","duration":"152.156662ms","start":"2026-06-15T11:49:43.904887Z","end":"2026-06-15T11:49:44.057044Z","steps":["trace[1007359506] 'agreement among raft nodes before linearized reading' (duration: 149.740885ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:49:44.056807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.47385ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T11:49:44.057146Z","caller":"traceutil/trace.go:171","msg":"trace[678071921] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:580; }","duration":"126.811828ms","start":"2026-06-15T11:49:43.930319Z","end":"2026-06-15T11:49:44.057131Z","steps":["trace[678071921] 'agreement among raft nodes before linearized reading' (duration: 124.200846ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:49:44.057227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.707054ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T11:49:44.057302Z","caller":"traceutil/trace.go:171","msg":"trace[2088043280] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:580; }","duration":"107.843347ms","start":"2026-06-15T11:49:43.949445Z","end":"2026-06-15T11:49:44.057289Z","steps":["trace[2088043280] 'agreement among raft nodes before linearized reading' (duration: 105.093722ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:49:44.057332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.365687ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T11:49:44.057413Z","caller":"traceutil/trace.go:171","msg":"trace[317081120] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:580; }","duration":"126.47338ms","start":"2026-06-15T11:49:43.930919Z","end":"2026-06-15T11:49:44.057392Z","steps":["trace[317081120] 'agreement among raft nodes before linearized reading' (duration: 123.664504ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:49:44.057987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.056691ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T11:49:44.058079Z","caller":"traceutil/trace.go:171","msg":"trace[1538687147] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:580; }","duration":"263.197805ms","start":"2026-06-15T11:49:43.794859Z","end":"2026-06-15T11:49:44.058057Z","steps":["trace[1538687147] 'agreement among raft nodes before linearized reading' (duration: 259.753083ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:49:44.058171Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.558428ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T11:49:44.058249Z","caller":"traceutil/trace.go:171","msg":"trace[212229513] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:580; }","duration":"238.685081ms","start":"2026-06-15T11:49:43.819538Z","end":"2026-06-15T11:49:44.058223Z","steps":["trace[212229513] 'agreement among raft nodes before linearized reading' (duration: 235.078895ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:49:44.058316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.452261ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T11:49:44.058499Z","caller":"traceutil/trace.go:171","msg":"trace[303754239] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:580; }","duration":"263.546813ms","start":"2026-06-15T11:49:43.794829Z","end":"2026-06-15T11:49:44.058376Z","steps":["trace[303754239] 'agreement among raft nodes before linearized reading' (duration: 259.808564ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:49:44.05834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.999487ms","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:5"} {"level":"info","ts":"2026-06-15T11:49:44.058605Z","caller":"traceutil/trace.go:171","msg":"trace[601498411] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:580; }","duration":"173.266044ms","start":"2026-06-15T11:49:43.885321Z","end":"2026-06-15T11:49:44.058587Z","steps":["trace[601498411] 'agreement among raft nodes before linearized reading' (duration: 169.31753ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:49:44.060009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.397679ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T11:49:44.060046Z","caller":"traceutil/trace.go:171","msg":"trace[508082134] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:580; }","duration":"155.45395ms","start":"2026-06-15T11:49:43.904583Z","end":"2026-06-15T11:49:44.060037Z","steps":["trace[508082134] 'agreement among raft nodes before linearized reading' (duration: 150.005031ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:49:50.014546Z","caller":"traceutil/trace.go:171","msg":"trace[943365273] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"141.418786ms","start":"2026-06-15T11:49:49.873098Z","end":"2026-06-15T11:49:50.014516Z","steps":["trace[943365273] 'process raft request' (duration: 138.424054ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:49:50.441588Z","caller":"traceutil/trace.go:171","msg":"trace[1320888664] linearizableReadLoop","detail":"{readStateIndex:662; appliedIndex:661; }","duration":"354.666771ms","start":"2026-06-15T11:49:50.086889Z","end":"2026-06-15T11:49:50.441556Z","steps":["trace[1320888664] 'read index received' (duration: 328.797015ms)","trace[1320888664] 'applied index is now lower than readState.Index' (duration: 25.868356ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T11:49:50.441706Z","caller":"traceutil/trace.go:171","msg":"trace[158981846] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"371.144783ms","start":"2026-06-15T11:49:50.070529Z","end":"2026-06-15T11:49:50.441673Z","steps":["trace[158981846] 'process raft request' (duration: 345.243497ms)","trace[158981846] 'compare' (duration: 25.484876ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T11:49:50.441828Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T11:49:50.070503Z","time spent":"371.268756ms","remote":"127.0.0.1:41782","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-15T11:49:50.441966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.05724ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-15T11:49:50.442042Z","caller":"traceutil/trace.go:171","msg":"trace[54167596] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:638; }","duration":"355.183523ms","start":"2026-06-15T11:49:50.086837Z","end":"2026-06-15T11:49:50.44202Z","steps":["trace[54167596] 'agreement among raft nodes before linearized reading' (duration: 354.884936ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:49:50.442083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.51831ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"warn","ts":"2026-06-15T11:49:50.442095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.237482ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-rrmjv\" ","response":"range_response_count:1 size:16965"} {"level":"warn","ts":"2026-06-15T11:49:50.442105Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T11:49:50.086812Z","time spent":"355.276806ms","remote":"127.0.0.1:41510","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-15T11:49:50.44214Z","caller":"traceutil/trace.go:171","msg":"trace[1055301773] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:638; }","duration":"215.613892ms","start":"2026-06-15T11:49:50.226505Z","end":"2026-06-15T11:49:50.442119Z","steps":["trace[1055301773] 'agreement among raft nodes before linearized reading' (duration: 215.505309ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:49:50.442153Z","caller":"traceutil/trace.go:171","msg":"trace[614920432] range","detail":"{range_begin:/registry/pods/kube-system/cilium-rrmjv; range_end:; response_count:1; response_revision:638; }","duration":"212.328613ms","start":"2026-06-15T11:49:50.229808Z","end":"2026-06-15T11:49:50.442137Z","steps":["trace[614920432] 'agreement among raft nodes before linearized reading' (duration: 212.152819ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:49:50.44197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.980489ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-06-15T11:49:50.442202Z","caller":"traceutil/trace.go:171","msg":"trace[1677696331] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:638; }","duration":"355.223524ms","start":"2026-06-15T11:49:50.086963Z","end":"2026-06-15T11:49:50.442186Z","steps":["trace[1677696331] 'agreement among raft nodes before linearized reading' (duration: 354.851975ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:49:50.442286Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T11:49:50.086862Z","time spent":"355.405258ms","remote":"127.0.0.1:41510","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-15T11:49:50.661747Z","caller":"traceutil/trace.go:171","msg":"trace[784142269] linearizableReadLoop","detail":"{readStateIndex:665; appliedIndex:663; }","duration":"209.893556ms","start":"2026-06-15T11:49:50.45183Z","end":"2026-06-15T11:49:50.661723Z","steps":["trace[784142269] 'read index received' (duration: 10.351606ms)","trace[784142269] 'applied index is now lower than readState.Index' (duration: 199.54115ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T11:49:50.661889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.036169ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T11:49:50.66192Z","caller":"traceutil/trace.go:171","msg":"trace[2125145577] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:642; }","duration":"210.108381ms","start":"2026-06-15T11:49:50.451802Z","end":"2026-06-15T11:49:50.66191Z","steps":["trace[2125145577] 'agreement among raft nodes before linearized reading' (duration: 210.04117ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:49:50.662108Z","caller":"traceutil/trace.go:171","msg":"trace[1259716421] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"213.591364ms","start":"2026-06-15T11:49:50.448291Z","end":"2026-06-15T11:49:50.661882Z","steps":["trace[1259716421] 'process raft request' (duration: 212.421176ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:49:50.662403Z","caller":"traceutil/trace.go:171","msg":"trace[496353703] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"207.783416ms","start":"2026-06-15T11:49:50.454586Z","end":"2026-06-15T11:49:50.66237Z","steps":["trace[496353703] 'process raft request' (duration: 207.042968ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:50:32.641876Z","caller":"traceutil/trace.go:171","msg":"trace[256289460] transaction","detail":"{read_only:false; response_revision:1192; number_of_response:1; }","duration":"247.794298ms","start":"2026-06-15T11:50:32.394049Z","end":"2026-06-15T11:50:32.641843Z","steps":["trace[256289460] 'process raft request' (duration: 223.299405ms)","trace[256289460] 'compare' (duration: 24.281078ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T11:50:32.880685Z","caller":"traceutil/trace.go:171","msg":"trace[175748787] transaction","detail":"{read_only:false; response_revision:1193; number_of_response:1; }","duration":"136.780816ms","start":"2026-06-15T11:50:32.743882Z","end":"2026-06-15T11:50:32.880663Z","steps":["trace[175748787] 'process raft request' (duration: 136.622992ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:50:32.886173Z","caller":"traceutil/trace.go:171","msg":"trace[362856573] transaction","detail":"{read_only:false; response_revision:1194; number_of_response:1; }","duration":"142.216365ms","start":"2026-06-15T11:50:32.743923Z","end":"2026-06-15T11:50:32.886139Z","steps":["trace[362856573] 'process raft request' (duration: 142.035711ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:51:06.955439Z","caller":"traceutil/trace.go:171","msg":"trace[797378706] linearizableReadLoop","detail":"{readStateIndex:1748; appliedIndex:1747; }","duration":"179.992334ms","start":"2026-06-15T11:51:06.775416Z","end":"2026-06-15T11:51:06.955408Z","steps":["trace[797378706] 'read index received' (duration: 179.655105ms)","trace[797378706] 'applied index is now lower than readState.Index' (duration: 335.848µs)"],"step_count":2} {"level":"info","ts":"2026-06-15T11:51:06.955548Z","caller":"traceutil/trace.go:171","msg":"trace[353588559] transaction","detail":"{read_only:false; response_revision:1684; number_of_response:1; }","duration":"258.662505ms","start":"2026-06-15T11:51:06.696814Z","end":"2026-06-15T11:51:06.955477Z","steps":["trace[353588559] 'process raft request' (duration: 258.330277ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:51:06.955663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.225309ms","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-06-15T11:51:06.955715Z","caller":"traceutil/trace.go:171","msg":"trace[1676242434] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:1684; }","duration":"180.365463ms","start":"2026-06-15T11:51:06.775337Z","end":"2026-06-15T11:51:06.955702Z","steps":["trace[1676242434] 'agreement among raft nodes before linearized reading' (duration: 180.210519ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:51:06.977999Z","caller":"traceutil/trace.go:171","msg":"trace[1278428874] transaction","detail":"{read_only:false; response_revision:1685; number_of_response:1; }","duration":"190.868394ms","start":"2026-06-15T11:51:06.787101Z","end":"2026-06-15T11:51:06.97797Z","steps":["trace[1278428874] 'process raft request' (duration: 190.70886ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:51:07.222361Z","caller":"traceutil/trace.go:171","msg":"trace[1065912203] transaction","detail":"{read_only:false; response_revision:1688; number_of_response:1; }","duration":"120.281526ms","start":"2026-06-15T11:51:07.102051Z","end":"2026-06-15T11:51:07.222333Z","steps":["trace[1065912203] 'process raft request' (duration: 55.351763ms)","trace[1065912203] 'compare' (duration: 64.699797ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T11:51:07.222672Z","caller":"traceutil/trace.go:171","msg":"trace[448034454] transaction","detail":"{read_only:false; response_revision:1690; number_of_response:1; }","duration":"119.996739ms","start":"2026-06-15T11:51:07.102652Z","end":"2026-06-15T11:51:07.222649Z","steps":["trace[448034454] 'process raft request' (duration: 119.896867ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:51:07.222698Z","caller":"traceutil/trace.go:171","msg":"trace[1292786055] transaction","detail":"{read_only:false; response_revision:1689; number_of_response:1; }","duration":"120.326347ms","start":"2026-06-15T11:51:07.102333Z","end":"2026-06-15T11:51:07.222659Z","steps":["trace[1292786055] 'process raft request' (duration: 119.949678ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:51:20.206567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.277364ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-15T11:51:20.207096Z","caller":"traceutil/trace.go:171","msg":"trace[1175642026] linearizableReadLoop","detail":"{readStateIndex:1940; appliedIndex:1939; }","duration":"429.705874ms","start":"2026-06-15T11:51:19.777365Z","end":"2026-06-15T11:51:20.20707Z","steps":["trace[1175642026] 'read index received' (duration: 160.59569ms)","trace[1175642026] 'applied index is now lower than readState.Index' (duration: 269.107874ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T11:51:20.207249Z","caller":"traceutil/trace.go:171","msg":"trace[1450159691] transaction","detail":"{read_only:false; response_revision:1868; number_of_response:1; }","duration":"441.555417ms","start":"2026-06-15T11:51:19.765659Z","end":"2026-06-15T11:51:20.207215Z","steps":["trace[1450159691] 'process raft request' (duration: 172.275419ms)","trace[1450159691] 'compare' (duration: 267.921196ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T11:51:20.207379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"429.944429ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T11:51:20.207424Z","caller":"traceutil/trace.go:171","msg":"trace[1545561089] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:1868; }","duration":"430.049432ms","start":"2026-06-15T11:51:19.77736Z","end":"2026-06-15T11:51:20.207409Z","steps":["trace[1545561089] 'agreement among raft nodes before linearized reading' (duration: 429.901128ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:51:20.207472Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T11:51:19.765634Z","time spent":"441.731081ms","remote":"127.0.0.1:41438","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10967,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T11:51:20.207476Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T11:51:19.777351Z","time spent":"430.113073ms","remote":"127.0.0.1:37306","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true "} {"level":"warn","ts":"2026-06-15T11:51:20.20765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"394.458191ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-eef8b043-c988-40a9-aa8d-2e946dce43ba\" ","response":"range_response_count:1 size:3744"} {"level":"info","ts":"2026-06-15T11:51:20.207688Z","caller":"traceutil/trace.go:171","msg":"trace[1360276615] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-eef8b043-c988-40a9-aa8d-2e946dce43ba; range_end:; response_count:1; response_revision:1868; }","duration":"394.546463ms","start":"2026-06-15T11:51:19.813133Z","end":"2026-06-15T11:51:20.207679Z","steps":["trace[1360276615] 'agreement among raft nodes before linearized reading' (duration: 394.38256ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:51:20.207717Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T11:51:19.813102Z","time spent":"394.609834ms","remote":"127.0.0.1:41438","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3767,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-eef8b043-c988-40a9-aa8d-2e946dce43ba\" "} {"level":"info","ts":"2026-06-15T11:51:20.788881Z","caller":"traceutil/trace.go:171","msg":"trace[1545709022] linearizableReadLoop","detail":"{readStateIndex:1945; appliedIndex:1944; }","duration":"223.010972ms","start":"2026-06-15T11:51:20.565848Z","end":"2026-06-15T11:51:20.788859Z","steps":["trace[1545709022] 'read index received' (duration: 222.796737ms)","trace[1545709022] 'applied index is now lower than readState.Index' (duration: 213.265µs)"],"step_count":2} {"level":"info","ts":"2026-06-15T11:51:20.788985Z","caller":"traceutil/trace.go:171","msg":"trace[2047250545] transaction","detail":"{read_only:false; response_revision:1873; number_of_response:1; }","duration":"348.258937ms","start":"2026-06-15T11:51:20.440682Z","end":"2026-06-15T11:51:20.788941Z","steps":["trace[2047250545] 'process raft request' (duration: 348.014371ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:51:20.789074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.211937ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-15T11:51:20.789106Z","caller":"traceutil/trace.go:171","msg":"trace[1574890086] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1873; }","duration":"223.300479ms","start":"2026-06-15T11:51:20.565796Z","end":"2026-06-15T11:51:20.789097Z","steps":["trace[1574890086] 'agreement among raft nodes before linearized reading' (duration: 223.168456ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:51:20.789152Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T11:51:20.440646Z","time spent":"348.42387ms","remote":"127.0.0.1:41510","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-06-15T11:51:20.844038Z","caller":"traceutil/trace.go:171","msg":"trace[72741855] transaction","detail":"{read_only:false; response_revision:1874; number_of_response:1; }","duration":"278.178111ms","start":"2026-06-15T11:51:20.565828Z","end":"2026-06-15T11:51:20.844007Z","steps":["trace[72741855] 'process raft request' (duration: 278.020347ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:51:20.844045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.125681ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T11:51:20.844232Z","caller":"traceutil/trace.go:171","msg":"trace[1413882609] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1874; }","duration":"235.336517ms","start":"2026-06-15T11:51:20.608878Z","end":"2026-06-15T11:51:20.844215Z","steps":["trace[1413882609] 'agreement among raft nodes before linearized reading' (duration: 235.086291ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:51:33.647868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.88484ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-15T11:51:33.64786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.298854ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T11:51:33.647954Z","caller":"traceutil/trace.go:171","msg":"trace[805042912] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:1979; }","duration":"108.041743ms","start":"2026-06-15T11:51:33.53989Z","end":"2026-06-15T11:51:33.647932Z","steps":["trace[805042912] 'count revisions from in-memory index tree' (duration: 107.787617ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:51:33.647996Z","caller":"traceutil/trace.go:171","msg":"trace[1547009241] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1979; }","duration":"250.443327ms","start":"2026-06-15T11:51:33.397528Z","end":"2026-06-15T11:51:33.647972Z","steps":["trace[1547009241] 'range keys from in-memory index tree' (duration: 250.282533ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:51:33.647954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.315085ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-06-15T11:51:33.648072Z","caller":"traceutil/trace.go:171","msg":"trace[1750819318] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1979; }","duration":"276.5092ms","start":"2026-06-15T11:51:33.371531Z","end":"2026-06-15T11:51:33.648041Z","steps":["trace[1750819318] 'range keys from in-memory index tree' (duration: 276.094971ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:51:33.648073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.256573ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-06-15T11:51:33.648155Z","caller":"traceutil/trace.go:171","msg":"trace[1807925962] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1979; }","duration":"291.384236ms","start":"2026-06-15T11:51:33.356749Z","end":"2026-06-15T11:51:33.648134Z","steps":["trace[1807925962] 'range keys from in-memory index tree' (duration: 291.066179ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:51:33.648288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.672629ms","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-06-15T11:51:33.648355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.379847ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-15T11:51:33.6484Z","caller":"traceutil/trace.go:171","msg":"trace[363968779] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1979; }","duration":"290.843103ms","start":"2026-06-15T11:51:33.357532Z","end":"2026-06-15T11:51:33.648375Z","steps":["trace[363968779] 'range keys from in-memory index tree' (duration: 290.465824ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:51:33.648463Z","caller":"traceutil/trace.go:171","msg":"trace[1943867806] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1979; }","duration":"286.543711ms","start":"2026-06-15T11:51:33.361894Z","end":"2026-06-15T11:51:33.648438Z","steps":["trace[1943867806] 'range keys from in-memory index tree' (duration: 286.114659ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:51:33.9765Z","caller":"traceutil/trace.go:171","msg":"trace[20657867] linearizableReadLoop","detail":"{readStateIndex:2057; appliedIndex:2054; }","duration":"318.462385ms","start":"2026-06-15T11:51:33.658004Z","end":"2026-06-15T11:51:33.976467Z","steps":["trace[20657867] 'read index received' (duration: 38.88685ms)","trace[20657867] 'applied index is now lower than readState.Index' (duration: 279.574605ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T11:51:33.976528Z","caller":"traceutil/trace.go:171","msg":"trace[8463294] transaction","detail":"{read_only:false; response_revision:1981; number_of_response:1; }","duration":"323.28283ms","start":"2026-06-15T11:51:33.65322Z","end":"2026-06-15T11:51:33.976503Z","steps":["trace[8463294] 'process raft request' (duration: 323.028374ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:51:33.976617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.601058ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T11:51:33.976647Z","caller":"traceutil/trace.go:171","msg":"trace[58579710] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:1982; }","duration":"318.671379ms","start":"2026-06-15T11:51:33.657967Z","end":"2026-06-15T11:51:33.976638Z","steps":["trace[58579710] 'agreement among raft nodes before linearized reading' (duration: 318.600257ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:51:33.976671Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T11:51:33.657953Z","time spent":"318.712691ms","remote":"127.0.0.1:41714","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":28,"request content":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" "} {"level":"warn","ts":"2026-06-15T11:51:33.976695Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T11:51:33.653209Z","time spent":"323.415143ms","remote":"127.0.0.1:41510","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-06-15T11:51:33.976656Z","caller":"traceutil/trace.go:171","msg":"trace[1817484905] transaction","detail":"{read_only:false; response_revision:1982; number_of_response:1; }","duration":"323.255709ms","start":"2026-06-15T11:51:33.653345Z","end":"2026-06-15T11:51:33.9766Z","steps":["trace[1817484905] 'process raft request' (duration: 323.076145ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:51:33.976887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.99927ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-06-15T11:51:33.976951Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T11:51:33.653321Z","time spent":"323.446163ms","remote":"127.0.0.1:41510","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T11:51:33.976994Z","caller":"traceutil/trace.go:171","msg":"trace[438760088] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1982; }","duration":"307.284057ms","start":"2026-06-15T11:51:33.669686Z","end":"2026-06-15T11:51:33.97697Z","steps":["trace[438760088] 'agreement among raft nodes before linearized reading' (duration: 306.98253ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:51:33.977049Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T11:51:33.669662Z","time spent":"307.377009ms","remote":"127.0.0.1:41510","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-15T11:51:34.169921Z","caller":"traceutil/trace.go:171","msg":"trace[1363959420] linearizableReadLoop","detail":"{readStateIndex:2058; appliedIndex:2057; }","duration":"181.722315ms","start":"2026-06-15T11:51:33.988172Z","end":"2026-06-15T11:51:34.169894Z","steps":["trace[1363959420] 'read index received' (duration: 82.498082ms)","trace[1363959420] 'applied index is now lower than readState.Index' (duration: 99.222592ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T11:51:34.169998Z","caller":"traceutil/trace.go:171","msg":"trace[272490834] transaction","detail":"{read_only:false; response_revision:1983; number_of_response:1; }","duration":"188.470606ms","start":"2026-06-15T11:51:33.981502Z","end":"2026-06-15T11:51:34.169973Z","steps":["trace[272490834] 'process raft request' (duration: 89.280814ms)","trace[272490834] 'compare' (duration: 98.984328ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T11:51:34.170202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.019662ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-06-15T11:51:34.170267Z","caller":"traceutil/trace.go:171","msg":"trace[703194203] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1983; }","duration":"182.129325ms","start":"2026-06-15T11:51:33.988117Z","end":"2026-06-15T11:51:34.170247Z","steps":["trace[703194203] 'agreement among raft nodes before linearized reading' (duration: 181.887609ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:51:34.781403Z","caller":"traceutil/trace.go:171","msg":"trace[983356238] linearizableReadLoop","detail":"{readStateIndex:2061; appliedIndex:2059; }","duration":"125.866719ms","start":"2026-06-15T11:51:34.655503Z","end":"2026-06-15T11:51:34.781369Z","steps":["trace[983356238] 'read index received' (duration: 33.352807ms)","trace[983356238] 'applied index is now lower than readState.Index' (duration: 92.512512ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T11:51:34.781574Z","caller":"traceutil/trace.go:171","msg":"trace[1636996721] transaction","detail":"{read_only:false; response_revision:1986; number_of_response:1; }","duration":"150.904318ms","start":"2026-06-15T11:51:34.630639Z","end":"2026-06-15T11:51:34.781544Z","steps":["trace[1636996721] 'process raft request' (duration: 150.496208ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:51:34.781748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.222388ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-06-15T11:51:34.781823Z","caller":"traceutil/trace.go:171","msg":"trace[1053052743] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1986; }","duration":"126.363201ms","start":"2026-06-15T11:51:34.655437Z","end":"2026-06-15T11:51:34.781801Z","steps":["trace[1053052743] 'agreement among raft nodes before linearized reading' (duration: 126.074264ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:51:38.535544Z","caller":"traceutil/trace.go:171","msg":"trace[1962000232] transaction","detail":"{read_only:false; response_revision:2015; number_of_response:1; }","duration":"338.905403ms","start":"2026-06-15T11:51:38.196613Z","end":"2026-06-15T11:51:38.535518Z","steps":["trace[1962000232] 'process raft request' (duration: 338.752019ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:51:38.535708Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T11:51:38.196597Z","time spent":"339.019155ms","remote":"127.0.0.1:41510","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T11:52:10.82518Z","caller":"traceutil/trace.go:171","msg":"trace[276036190] transaction","detail":"{read_only:false; response_revision:2193; number_of_response:1; }","duration":"140.830735ms","start":"2026-06-15T11:52:10.684323Z","end":"2026-06-15T11:52:10.825154Z","steps":["trace[276036190] 'process raft request' (duration: 140.6533ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:52:11.130113Z","caller":"traceutil/trace.go:171","msg":"trace[354742642] transaction","detail":"{read_only:false; response_revision:2195; number_of_response:1; }","duration":"102.902553ms","start":"2026-06-15T11:52:11.027173Z","end":"2026-06-15T11:52:11.130075Z","steps":["trace[354742642] 'process raft request' (duration: 58.752582ms)","trace[354742642] 'compare' (duration: 43.931176ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T11:52:17.315518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.924657ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-15T11:52:17.315814Z","caller":"traceutil/trace.go:171","msg":"trace[503894605] transaction","detail":"{read_only:false; response_revision:2227; number_of_response:1; }","duration":"164.687558ms","start":"2026-06-15T11:52:17.151108Z","end":"2026-06-15T11:52:17.315796Z","steps":["trace[503894605] 'process raft request' (duration: 164.593706ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:52:17.315817Z","caller":"traceutil/trace.go:171","msg":"trace[1668210505] transaction","detail":"{read_only:false; response_revision:2226; number_of_response:1; }","duration":"320.462481ms","start":"2026-06-15T11:52:16.995305Z","end":"2026-06-15T11:52:17.315767Z","steps":["trace[1668210505] 'process raft request' (duration: 55.023602ms)","trace[1668210505] 'compare' (duration: 264.598389ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T11:52:17.315831Z","caller":"traceutil/trace.go:171","msg":"trace[1665446254] linearizableReadLoop","detail":"{readStateIndex:2310; appliedIndex:2309; }","duration":"209.046374ms","start":"2026-06-15T11:52:17.106745Z","end":"2026-06-15T11:52:17.315792Z","steps":["trace[1665446254] 'read index received' (duration: 77.901µs)","trace[1665446254] 'applied index is now lower than readState.Index' (duration: 208.962563ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T11:52:17.315963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.206478ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-15T11:52:17.315998Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T11:52:16.995268Z","time spent":"320.633735ms","remote":"127.0.0.1:41510","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-06-15T11:52:17.316027Z","caller":"traceutil/trace.go:171","msg":"trace[300756988] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:2227; }","duration":"209.331341ms","start":"2026-06-15T11:52:17.10668Z","end":"2026-06-15T11:52:17.316011Z","steps":["trace[300756988] 'agreement among raft nodes before linearized reading' (duration: 209.165197ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:52:17.316154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.434411ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-06-15T11:52:17.316241Z","caller":"traceutil/trace.go:171","msg":"trace[1964897906] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2227; }","duration":"139.564444ms","start":"2026-06-15T11:52:17.176656Z","end":"2026-06-15T11:52:17.31622Z","steps":["trace[1964897906] 'agreement among raft nodes before linearized reading' (duration: 139.299118ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:52:17.316267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.926453ms","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-06-15T11:52:17.316301Z","caller":"traceutil/trace.go:171","msg":"trace[1109871895] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2227; }","duration":"135.004805ms","start":"2026-06-15T11:52:17.181286Z","end":"2026-06-15T11:52:17.316291Z","steps":["trace[1109871895] 'agreement among raft nodes before linearized reading' (duration: 134.873082ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:52:17.736694Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.400646ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-15T11:52:17.737002Z","caller":"traceutil/trace.go:171","msg":"trace[93539068] linearizableReadLoop","detail":"{readStateIndex:2316; appliedIndex:2312; }","duration":"126.188351ms","start":"2026-06-15T11:52:17.610792Z","end":"2026-06-15T11:52:17.736981Z","steps":["trace[93539068] 'read index received' (duration: 83.245069ms)","trace[93539068] 'applied index is now lower than readState.Index' (duration: 42.942332ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T11:52:17.737116Z","caller":"traceutil/trace.go:171","msg":"trace[650591839] transaction","detail":"{read_only:false; response_revision:2228; number_of_response:1; }","duration":"414.680754ms","start":"2026-06-15T11:52:17.322423Z","end":"2026-06-15T11:52:17.737104Z","steps":["trace[650591839] 'process raft request' (duration: 287.784046ms)","trace[650591839] 'compare' (duration: 126.226932ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T11:52:17.737191Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T11:52:17.322381Z","time spent":"414.772077ms","remote":"127.0.0.1:41510","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-06-15T11:52:17.737465Z","caller":"traceutil/trace.go:171","msg":"trace[1780425653] transaction","detail":"{read_only:false; response_revision:2231; number_of_response:1; }","duration":"347.982751ms","start":"2026-06-15T11:52:17.389445Z","end":"2026-06-15T11:52:17.737427Z","steps":["trace[1780425653] 'process raft request' (duration: 347.484969ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:52:17.737465Z","caller":"traceutil/trace.go:171","msg":"trace[53994724] transaction","detail":"{read_only:false; response_revision:2229; number_of_response:1; }","duration":"400.899603ms","start":"2026-06-15T11:52:17.336539Z","end":"2026-06-15T11:52:17.737438Z","steps":["trace[53994724] 'process raft request' (duration: 400.263368ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:52:17.737647Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T11:52:17.389427Z","time spent":"348.134385ms","remote":"127.0.0.1:41278","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T11:52:17.737728Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T11:52:17.336517Z","time spent":"401.147379ms","remote":"127.0.0.1:41510","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-06-15T11:52:17.737478Z","caller":"traceutil/trace.go:171","msg":"trace[778030200] transaction","detail":"{read_only:false; response_revision:2230; number_of_response:1; }","duration":"374.572531ms","start":"2026-06-15T11:52:17.362875Z","end":"2026-06-15T11:52:17.737448Z","steps":["trace[778030200] 'process raft request' (duration: 374.008787ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:52:17.737496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.691513ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-15T11:52:17.738001Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T11:52:17.362856Z","time spent":"375.012101ms","remote":"127.0.0.1:41510","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T11:52:17.738029Z","caller":"traceutil/trace.go:171","msg":"trace[926668995] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2231; }","duration":"127.272507ms","start":"2026-06-15T11:52:17.610738Z","end":"2026-06-15T11:52:17.738011Z","steps":["trace[926668995] 'agreement among raft nodes before linearized reading' (duration: 126.692083ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:53:00.413305Z","caller":"traceutil/trace.go:171","msg":"trace[651495901] transaction","detail":"{read_only:false; response_revision:2635; number_of_response:1; }","duration":"254.414333ms","start":"2026-06-15T11:53:00.15886Z","end":"2026-06-15T11:53:00.413274Z","steps":["trace[651495901] 'process raft request' (duration: 254.221129ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:53:34.405166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.39604ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-15T11:53:34.405318Z","caller":"traceutil/trace.go:171","msg":"trace[1708707] linearizableReadLoop","detail":"{readStateIndex:2948; appliedIndex:2947; }","duration":"274.080546ms","start":"2026-06-15T11:53:34.131193Z","end":"2026-06-15T11:53:34.405273Z","steps":["trace[1708707] 'read index received' (duration: 109.43175ms)","trace[1708707] 'applied index is now lower than readState.Index' (duration: 164.644496ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T11:53:34.405337Z","caller":"traceutil/trace.go:171","msg":"trace[1285312753] transaction","detail":"{read_only:false; response_revision:2839; number_of_response:1; }","duration":"404.650165ms","start":"2026-06-15T11:53:34.000629Z","end":"2026-06-15T11:53:34.405279Z","steps":["trace[1285312753] 'process raft request' (duration: 240.042419ms)","trace[1285312753] 'compare' (duration: 163.923899ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T11:53:34.405474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.294581ms","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":"warn","ts":"2026-06-15T11:53:34.405485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T11:53:34.000596Z","time spent":"404.806058ms","remote":"127.0.0.1:41510","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-06-15T11:53:34.405514Z","caller":"traceutil/trace.go:171","msg":"trace[1209741250] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2839; }","duration":"274.387034ms","start":"2026-06-15T11:53:34.131117Z","end":"2026-06-15T11:53:34.405504Z","steps":["trace[1209741250] 'agreement among raft nodes before linearized reading' (duration: 274.23249ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:57:37.721985Z","caller":"traceutil/trace.go:171","msg":"trace[1393940139] linearizableReadLoop","detail":"{readStateIndex:5269; appliedIndex:5267; }","duration":"341.505022ms","start":"2026-06-15T11:57:37.380427Z","end":"2026-06-15T11:57:37.721932Z","steps":["trace[1393940139] 'read index received' (duration: 124.783116ms)","trace[1393940139] 'applied index is now lower than readState.Index' (duration: 216.720776ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T11:57:37.722126Z","caller":"traceutil/trace.go:171","msg":"trace[1122192279] transaction","detail":"{read_only:false; response_revision:5078; number_of_response:1; }","duration":"400.010944ms","start":"2026-06-15T11:57:37.322087Z","end":"2026-06-15T11:57:37.722098Z","steps":["trace[1122192279] 'process raft request' (duration: 387.850737ms)","trace[1122192279] 'compare' (duration: 11.84211ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T11:57:37.72224Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T11:57:37.322063Z","time spent":"400.091277ms","remote":"127.0.0.1:41510","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-06-15T11:57:37.722444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.005514ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c01b2ed4-8219-4b7a-8ee8-4eb6e31f5188\" ","response":"range_response_count:1 size:3601"} {"level":"info","ts":"2026-06-15T11:57:37.722505Z","caller":"traceutil/trace.go:171","msg":"trace[1603518046] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-c01b2ed4-8219-4b7a-8ee8-4eb6e31f5188; range_end:; response_count:1; response_revision:5078; }","duration":"342.110807ms","start":"2026-06-15T11:57:37.380379Z","end":"2026-06-15T11:57:37.72249Z","steps":["trace[1603518046] 'agreement among raft nodes before linearized reading' (duration: 341.761008ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:57:37.722595Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T11:57:37.380359Z","time spent":"342.205179ms","remote":"127.0.0.1:41438","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-c01b2ed4-8219-4b7a-8ee8-4eb6e31f5188\" "} {"level":"info","ts":"2026-06-15T11:57:37.755811Z","caller":"traceutil/trace.go:171","msg":"trace[757065259] transaction","detail":"{read_only:false; response_revision:5079; number_of_response:1; }","duration":"248.996417ms","start":"2026-06-15T11:57:37.506775Z","end":"2026-06-15T11:57:37.755772Z","steps":["trace[757065259] 'process raft request' (duration: 248.672719ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:57:37.756352Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.756254ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T11:57:37.756421Z","caller":"traceutil/trace.go:171","msg":"trace[1090507469] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5080; }","duration":"144.840966ms","start":"2026-06-15T11:57:37.61156Z","end":"2026-06-15T11:57:37.756401Z","steps":["trace[1090507469] 'agreement among raft nodes before linearized reading' (duration: 144.723073ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:57:37.756905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.930227ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:25 size:786820"} {"level":"info","ts":"2026-06-15T11:57:37.757038Z","caller":"traceutil/trace.go:171","msg":"trace[1472399343] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:25; response_revision:5080; }","duration":"332.100041ms","start":"2026-06-15T11:57:37.424907Z","end":"2026-06-15T11:57:37.757007Z","steps":["trace[1472399343] 'agreement among raft nodes before linearized reading' (duration: 331.416144ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:57:37.757092Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T11:57:37.424896Z","time spent":"332.184694ms","remote":"127.0.0.1:41348","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":25,"response size":786843,"request content":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" "} {"level":"warn","ts":"2026-06-15T11:57:37.757874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.524701ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/monitoring/vector\" ","response":"range_response_count:1 size:894"} {"level":"info","ts":"2026-06-15T11:57:37.757985Z","caller":"traceutil/trace.go:171","msg":"trace[114292675] range","detail":"{range_begin:/registry/serviceaccounts/monitoring/vector; range_end:; response_count:1; response_revision:5080; }","duration":"352.751638ms","start":"2026-06-15T11:57:37.405207Z","end":"2026-06-15T11:57:37.757959Z","steps":["trace[114292675] 'agreement among raft nodes before linearized reading' (duration: 350.912222ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:57:37.758024Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T11:57:37.405199Z","time spent":"352.815989ms","remote":"127.0.0.1:41450","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":917,"request content":"key:\"/registry/serviceaccounts/monitoring/vector\" "} {"level":"warn","ts":"2026-06-15T11:57:38.176909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.633603ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-15T11:57:38.177036Z","caller":"traceutil/trace.go:171","msg":"trace[416887826] linearizableReadLoop","detail":"{readStateIndex:5274; appliedIndex:5273; }","duration":"134.766749ms","start":"2026-06-15T11:57:38.042251Z","end":"2026-06-15T11:57:38.177017Z","steps":["trace[416887826] 'read index received' (duration: 58.531µs)","trace[416887826] 'applied index is now lower than readState.Index' (duration: 134.706798ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T11:57:38.177157Z","caller":"traceutil/trace.go:171","msg":"trace[446348768] transaction","detail":"{read_only:false; response_revision:5083; number_of_response:1; }","duration":"162.17783ms","start":"2026-06-15T11:57:38.014961Z","end":"2026-06-15T11:57:38.177139Z","steps":["trace[446348768] 'process raft request' (duration: 19.240501ms)","trace[446348768] 'compare' (duration: 142.485458ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T11:57:38.177335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.078058ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-06-15T11:57:38.177401Z","caller":"traceutil/trace.go:171","msg":"trace[1496658727] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5083; }","duration":"135.19468ms","start":"2026-06-15T11:57:38.042193Z","end":"2026-06-15T11:57:38.177388Z","steps":["trace[1496658727] 'agreement among raft nodes before linearized reading' (duration: 135.021076ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:57:38.177339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.690656ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-15T11:57:38.177479Z","caller":"traceutil/trace.go:171","msg":"trace[1184389558] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5083; }","duration":"100.86353ms","start":"2026-06-15T11:57:38.076586Z","end":"2026-06-15T11:57:38.177449Z","steps":["trace[1184389558] 'agreement among raft nodes before linearized reading' (duration: 100.580043ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:57:44.873562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.437387ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-15T11:57:44.873938Z","caller":"traceutil/trace.go:171","msg":"trace[911900487] linearizableReadLoop","detail":"{readStateIndex:5424; appliedIndex:5422; }","duration":"121.488704ms","start":"2026-06-15T11:57:44.752356Z","end":"2026-06-15T11:57:44.873845Z","steps":["trace[911900487] 'read index received' (duration: 5.682959ms)","trace[911900487] 'applied index is now lower than readState.Index' (duration: 115.804485ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T11:57:44.874073Z","caller":"traceutil/trace.go:171","msg":"trace[360557268] transaction","detail":"{read_only:false; response_revision:5226; number_of_response:1; }","duration":"126.001066ms","start":"2026-06-15T11:57:44.748059Z","end":"2026-06-15T11:57:44.87406Z","steps":["trace[360557268] 'compare' (duration: 113.727985ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:57:44.874556Z","caller":"traceutil/trace.go:171","msg":"trace[1335757669] transaction","detail":"{read_only:false; response_revision:5227; number_of_response:1; }","duration":"124.402296ms","start":"2026-06-15T11:57:44.75013Z","end":"2026-06-15T11:57:44.874533Z","steps":["trace[1335757669] 'process raft request' (duration: 123.576616ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:57:44.87485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.484159ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/prometheus-pushgateway-7b8659c68b-8pjth\" ","response":"range_response_count:1 size:3128"} {"level":"info","ts":"2026-06-15T11:57:44.874935Z","caller":"traceutil/trace.go:171","msg":"trace[2097177969] range","detail":"{range_begin:/registry/pods/monitoring/prometheus-pushgateway-7b8659c68b-8pjth; range_end:; response_count:1; response_revision:5227; }","duration":"122.595312ms","start":"2026-06-15T11:57:44.752304Z","end":"2026-06-15T11:57:44.874899Z","steps":["trace[2097177969] 'agreement among raft nodes before linearized reading' (duration: 122.377257ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:57:44.878965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.089706ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:28 size:824990"} {"level":"info","ts":"2026-06-15T11:57:44.879134Z","caller":"traceutil/trace.go:171","msg":"trace[680573358] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:28; response_revision:5227; }","duration":"119.311301ms","start":"2026-06-15T11:57:44.75977Z","end":"2026-06-15T11:57:44.879081Z","steps":["trace[680573358] 'agreement among raft nodes before linearized reading' (duration: 114.987666ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:57:45.186282Z","caller":"traceutil/trace.go:171","msg":"trace[120742169] transaction","detail":"{read_only:false; response_revision:5235; number_of_response:1; }","duration":"107.948873ms","start":"2026-06-15T11:57:45.078309Z","end":"2026-06-15T11:57:45.186258Z","steps":["trace[120742169] 'process raft request' (duration: 104.270683ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:57:52.560403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.856258ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-15T11:57:52.560507Z","caller":"traceutil/trace.go:171","msg":"trace[1747891075] linearizableReadLoop","detail":"{readStateIndex:5542; appliedIndex:5541; }","duration":"263.841271ms","start":"2026-06-15T11:57:52.29665Z","end":"2026-06-15T11:57:52.560491Z","steps":["trace[1747891075] 'read index received' (duration: 158.753808ms)","trace[1747891075] 'applied index is now lower than readState.Index' (duration: 105.086143ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T11:57:52.56059Z","caller":"traceutil/trace.go:171","msg":"trace[697222992] transaction","detail":"{read_only:false; response_revision:5343; number_of_response:1; }","duration":"270.542735ms","start":"2026-06-15T11:57:52.290036Z","end":"2026-06-15T11:57:52.560579Z","steps":["trace[697222992] 'process raft request' (duration: 165.425191ms)","trace[697222992] 'compare' (duration: 104.751215ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T11:57:52.560708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.659935ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T11:57:52.56076Z","caller":"traceutil/trace.go:171","msg":"trace[564441217] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:5343; }","duration":"236.756627ms","start":"2026-06-15T11:57:52.323988Z","end":"2026-06-15T11:57:52.560745Z","steps":["trace[564441217] 'agreement among raft nodes before linearized reading' (duration: 236.667545ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:57:52.560985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.297732ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-06-15T11:57:52.561054Z","caller":"traceutil/trace.go:171","msg":"trace[99744208] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5343; }","duration":"264.417584ms","start":"2026-06-15T11:57:52.296623Z","end":"2026-06-15T11:57:52.56104Z","steps":["trace[99744208] 'agreement among raft nodes before linearized reading' (duration: 264.188239ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:57:52.561046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.42097ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-k46bw\" ","response":"range_response_count:1 size:6451"} {"level":"info","ts":"2026-06-15T11:57:52.561127Z","caller":"traceutil/trace.go:171","msg":"trace[198073813] range","detail":"{range_begin:/registry/pods/openstack/keepalived-k46bw; range_end:; response_count:1; response_revision:5343; }","duration":"147.540123ms","start":"2026-06-15T11:57:52.413572Z","end":"2026-06-15T11:57:52.561112Z","steps":["trace[198073813] 'agreement among raft nodes before linearized reading' (duration: 147.240946ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:58:00.544098Z","caller":"traceutil/trace.go:171","msg":"trace[895398619] linearizableReadLoop","detail":"{readStateIndex:5740; appliedIndex:5739; }","duration":"159.547117ms","start":"2026-06-15T11:58:00.384533Z","end":"2026-06-15T11:58:00.54408Z","steps":["trace[895398619] 'read index received' (duration: 159.367963ms)","trace[895398619] 'applied index is now lower than readState.Index' (duration: 178.594µs)"],"step_count":2} {"level":"info","ts":"2026-06-15T11:58:00.544158Z","caller":"traceutil/trace.go:171","msg":"trace[213148705] transaction","detail":"{read_only:false; response_revision:5536; number_of_response:1; }","duration":"238.603092ms","start":"2026-06-15T11:58:00.305519Z","end":"2026-06-15T11:58:00.544122Z","steps":["trace[213148705] 'process raft request' (duration: 238.435338ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:58:00.544265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.712391ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-785c41cd-4d91-41c1-b17a-9433e2e3428b\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-06-15T11:58:00.544291Z","caller":"traceutil/trace.go:171","msg":"trace[616547332] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-785c41cd-4d91-41c1-b17a-9433e2e3428b; range_end:; response_count:1; response_revision:5536; }","duration":"159.798693ms","start":"2026-06-15T11:58:00.384486Z","end":"2026-06-15T11:58:00.544284Z","steps":["trace[616547332] 'agreement among raft nodes before linearized reading' (duration: 159.67883ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:58:00.729339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.828871ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-k46bw\" ","response":"range_response_count:1 size:6451"} {"level":"info","ts":"2026-06-15T11:58:00.729411Z","caller":"traceutil/trace.go:171","msg":"trace[1062153965] range","detail":"{range_begin:/registry/pods/openstack/keepalived-k46bw; range_end:; response_count:1; response_revision:5536; }","duration":"116.934604ms","start":"2026-06-15T11:58:00.612462Z","end":"2026-06-15T11:58:00.729397Z","steps":["trace[1062153965] 'range keys from in-memory index tree' (duration: 116.654197ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:58:00.729491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.933042ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-15T11:58:00.729598Z","caller":"traceutil/trace.go:171","msg":"trace[966391408] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5536; }","duration":"130.106736ms","start":"2026-06-15T11:58:00.599465Z","end":"2026-06-15T11:58:00.729572Z","steps":["trace[966391408] 'range keys from in-memory index tree' (duration: 129.686495ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:58:00.730336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.33659ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-06-15T11:58:00.730397Z","caller":"traceutil/trace.go:171","msg":"trace[581665133] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5536; }","duration":"123.448013ms","start":"2026-06-15T11:58:00.606934Z","end":"2026-06-15T11:58:00.730382Z","steps":["trace[581665133] 'range keys from in-memory index tree' (duration: 123.112245ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:58:00.966434Z","caller":"traceutil/trace.go:171","msg":"trace[1390212367] transaction","detail":"{read_only:false; response_revision:5538; number_of_response:1; }","duration":"241.773361ms","start":"2026-06-15T11:58:00.724616Z","end":"2026-06-15T11:58:00.966389Z","steps":["trace[1390212367] 'process raft request' (duration: 156.616925ms)","trace[1390212367] 'compare' (duration: 84.51535ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T11:58:00.966752Z","caller":"traceutil/trace.go:171","msg":"trace[1012640851] transaction","detail":"{read_only:false; response_revision:5539; number_of_response:1; }","duration":"233.301163ms","start":"2026-06-15T11:58:00.733417Z","end":"2026-06-15T11:58:00.966718Z","steps":["trace[1012640851] 'process raft request' (duration: 233.114068ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:58:00.966885Z","caller":"traceutil/trace.go:171","msg":"trace[849260547] transaction","detail":"{read_only:false; response_revision:5540; number_of_response:1; }","duration":"232.425551ms","start":"2026-06-15T11:58:00.734395Z","end":"2026-06-15T11:58:00.96682Z","steps":["trace[849260547] 'process raft request' (duration: 232.224716ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:58:00.966764Z","caller":"traceutil/trace.go:171","msg":"trace[2145757090] transaction","detail":"{read_only:false; response_revision:5541; number_of_response:1; }","duration":"181.117445ms","start":"2026-06-15T11:58:00.785621Z","end":"2026-06-15T11:58:00.966738Z","steps":["trace[2145757090] 'process raft request' (duration: 181.064554ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:58:00.966828Z","caller":"traceutil/trace.go:171","msg":"trace[1484522886] linearizableReadLoop","detail":"{readStateIndex:5744; appliedIndex:5741; }","duration":"186.578459ms","start":"2026-06-15T11:58:00.780236Z","end":"2026-06-15T11:58:00.966814Z","steps":["trace[1484522886] 'read index received' (duration: 101.052425ms)","trace[1484522886] 'applied index is now lower than readState.Index' (duration: 85.524894ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T11:58:00.967207Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.865412ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:9 size:80046"} {"level":"info","ts":"2026-06-15T11:58:00.967283Z","caller":"traceutil/trace.go:171","msg":"trace[732065964] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:9; response_revision:5541; }","duration":"232.958564ms","start":"2026-06-15T11:58:00.734308Z","end":"2026-06-15T11:58:00.967267Z","steps":["trace[732065964] 'agreement among raft nodes before linearized reading' (duration: 232.547694ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:58:01.219991Z","caller":"traceutil/trace.go:171","msg":"trace[664631714] linearizableReadLoop","detail":"{readStateIndex:5746; appliedIndex:5745; }","duration":"150.118495ms","start":"2026-06-15T11:58:01.06985Z","end":"2026-06-15T11:58:01.219968Z","steps":["trace[664631714] 'read index received' (duration: 149.88931ms)","trace[664631714] 'applied index is now lower than readState.Index' (duration: 227.995µs)"],"step_count":2} {"level":"warn","ts":"2026-06-15T11:58:01.221395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.5157ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/federations/\" range_end:\"/registry/rabbitmq.com/federations0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T11:58:01.221297Z","caller":"traceutil/trace.go:171","msg":"trace[2089423856] transaction","detail":"{read_only:false; response_revision:5542; number_of_response:1; }","duration":"225.661216ms","start":"2026-06-15T11:58:00.994484Z","end":"2026-06-15T11:58:01.220145Z","steps":["trace[2089423856] 'process raft request' (duration: 225.327058ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:58:01.221444Z","caller":"traceutil/trace.go:171","msg":"trace[892526853] range","detail":"{range_begin:/registry/rabbitmq.com/federations/; range_end:/registry/rabbitmq.com/federations0; response_count:0; response_revision:5542; }","duration":"151.637073ms","start":"2026-06-15T11:58:01.069794Z","end":"2026-06-15T11:58:01.221431Z","steps":["trace[892526853] 'agreement among raft nodes before linearized reading' (duration: 150.29159ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:58:03.183693Z","caller":"traceutil/trace.go:171","msg":"trace[276919415] linearizableReadLoop","detail":"{readStateIndex:5777; appliedIndex:5776; }","duration":"111.131071ms","start":"2026-06-15T11:58:03.072533Z","end":"2026-06-15T11:58:03.183664Z","steps":["trace[276919415] 'read index received' (duration: 25.153936ms)","trace[276919415] 'applied index is now lower than readState.Index' (duration: 85.976075ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T11:58:03.183776Z","caller":"traceutil/trace.go:171","msg":"trace[1356091663] transaction","detail":"{read_only:false; response_revision:5572; number_of_response:1; }","duration":"115.011877ms","start":"2026-06-15T11:58:03.068729Z","end":"2026-06-15T11:58:03.183741Z","steps":["trace[1356091663] 'process raft request' (duration: 29.074023ms)","trace[1356091663] 'compare' (duration: 85.721678ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T11:58:03.184005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.452879ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/monitoring/prometheus-kube-prometheus-stack-prometheus-0-tls\" ","response":"range_response_count:1 size:2319"} {"level":"info","ts":"2026-06-15T11:58:03.184077Z","caller":"traceutil/trace.go:171","msg":"trace[297103746] range","detail":"{range_begin:/registry/cert-manager.io/certificates/monitoring/prometheus-kube-prometheus-stack-prometheus-0-tls; range_end:; response_count:1; response_revision:5572; }","duration":"111.560011ms","start":"2026-06-15T11:58:03.072498Z","end":"2026-06-15T11:58:03.184058Z","steps":["trace[297103746] 'agreement among raft nodes before linearized reading' (duration: 111.256144ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:58:13.482551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"584.600745ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-06-15T11:58:13.483324Z","caller":"traceutil/trace.go:171","msg":"trace[527698349] linearizableReadLoop","detail":"{readStateIndex:5871; appliedIndex:5869; }","duration":"653.763368ms","start":"2026-06-15T11:58:12.829541Z","end":"2026-06-15T11:58:13.483304Z","steps":["trace[527698349] 'read index received' (duration: 68.459626ms)","trace[527698349] 'applied index is now lower than readState.Index' (duration: 585.302502ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T11:58:13.483367Z","caller":"traceutil/trace.go:171","msg":"trace[897549330] transaction","detail":"{read_only:false; response_revision:5664; number_of_response:1; }","duration":"663.587139ms","start":"2026-06-15T11:58:12.819754Z","end":"2026-06-15T11:58:13.483341Z","steps":["trace[897549330] 'process raft request' (duration: 663.364773ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:58:13.483471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"653.932002ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/scrapeconfigs/\" range_end:\"/registry/monitoring.coreos.com/scrapeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T11:58:13.483462Z","caller":"traceutil/trace.go:171","msg":"trace[1944662922] transaction","detail":"{read_only:false; response_revision:5665; number_of_response:1; }","duration":"464.77404ms","start":"2026-06-15T11:58:13.018654Z","end":"2026-06-15T11:58:13.483428Z","steps":["trace[1944662922] 'process raft request' (duration: 464.611416ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:58:13.483503Z","caller":"traceutil/trace.go:171","msg":"trace[1799102952] range","detail":"{range_begin:/registry/monitoring.coreos.com/scrapeconfigs/; range_end:/registry/monitoring.coreos.com/scrapeconfigs0; response_count:0; response_revision:5665; }","duration":"654.027814ms","start":"2026-06-15T11:58:12.829465Z","end":"2026-06-15T11:58:13.483493Z","steps":["trace[1799102952] 'agreement among raft nodes before linearized reading' (duration: 653.944112ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:58:13.483506Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T11:58:12.819722Z","time spent":"663.705422ms","remote":"127.0.0.1:41510","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T11:58:13.483547Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T11:58:12.829438Z","time spent":"654.100207ms","remote":"127.0.0.1:53372","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/monitoring.coreos.com/scrapeconfigs/\" range_end:\"/registry/monitoring.coreos.com/scrapeconfigs0\" count_only:true "} {"level":"warn","ts":"2026-06-15T11:58:13.483668Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T11:58:13.018633Z","time spent":"464.906394ms","remote":"127.0.0.1:41510","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T11:58:13.504385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"590.789646ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-15T11:58:13.504436Z","caller":"traceutil/trace.go:171","msg":"trace[2054970079] transaction","detail":"{read_only:false; response_revision:5666; number_of_response:1; }","duration":"179.484655ms","start":"2026-06-15T11:58:13.324923Z","end":"2026-06-15T11:58:13.504408Z","steps":["trace[2054970079] 'process raft request' (duration: 179.201548ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:58:13.504474Z","caller":"traceutil/trace.go:171","msg":"trace[416469514] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:5666; }","duration":"590.93696ms","start":"2026-06-15T11:58:12.913518Z","end":"2026-06-15T11:58:13.504455Z","steps":["trace[416469514] 'agreement among raft nodes before linearized reading' (duration: 590.760625ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:58:13.504523Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T11:58:12.913496Z","time spent":"591.017231ms","remote":"127.0.0.1:41734","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":10,"response size":30,"request content":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true "} {"level":"warn","ts":"2026-06-15T11:58:13.504564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"458.122388ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-06-15T11:58:13.504578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"449.692561ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-k46bw\" ","response":"range_response_count:1 size:6451"} {"level":"warn","ts":"2026-06-15T11:58:13.504616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"480.636518ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-15T11:58:13.504623Z","caller":"traceutil/trace.go:171","msg":"trace[234341939] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5666; }","duration":"458.213849ms","start":"2026-06-15T11:58:13.046391Z","end":"2026-06-15T11:58:13.504605Z","steps":["trace[234341939] 'agreement among raft nodes before linearized reading' (duration: 457.982404ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:58:13.504649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"452.149201ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-06-15T11:58:13.504654Z","caller":"traceutil/trace.go:171","msg":"trace[2104693621] range","detail":"{range_begin:/registry/pods/openstack/keepalived-k46bw; range_end:; response_count:1; response_revision:5666; }","duration":"449.785343ms","start":"2026-06-15T11:58:13.05485Z","end":"2026-06-15T11:58:13.504636Z","steps":["trace[2104693621] 'agreement among raft nodes before linearized reading' (duration: 449.504466ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T11:58:13.504675Z","caller":"traceutil/trace.go:171","msg":"trace[971227304] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5666; }","duration":"480.722571ms","start":"2026-06-15T11:58:13.023934Z","end":"2026-06-15T11:58:13.504657Z","steps":["trace[971227304] 'agreement among raft nodes before linearized reading' (duration: 480.524756ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:58:13.504681Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T11:58:13.046379Z","time spent":"458.293271ms","remote":"127.0.0.1:41510","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-15T11:58:13.504701Z","caller":"traceutil/trace.go:171","msg":"trace[228785300] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5666; }","duration":"452.224823ms","start":"2026-06-15T11:58:13.052463Z","end":"2026-06-15T11:58:13.504687Z","steps":["trace[228785300] 'agreement among raft nodes before linearized reading' (duration: 452.08151ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:58:13.504713Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T11:58:13.023922Z","time spent":"480.785133ms","remote":"127.0.0.1:41510","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-15T11:58:13.504712Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T11:58:13.054808Z","time spent":"449.894956ms","remote":"127.0.0.1:41438","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6474,"request content":"key:\"/registry/pods/openstack/keepalived-k46bw\" "} {"level":"warn","ts":"2026-06-15T11:58:13.504741Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T11:58:13.052452Z","time spent":"452.281465ms","remote":"127.0.0.1:41510","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-06-15T11:58:13.504857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"556.278881ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"warn","ts":"2026-06-15T11:58:13.50488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"382.802753ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-06-15T11:58:13.504954Z","caller":"traceutil/trace.go:171","msg":"trace[1466313562] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5666; }","duration":"556.439765ms","start":"2026-06-15T11:58:12.948488Z","end":"2026-06-15T11:58:13.504928Z","steps":["trace[1466313562] 'agreement among raft nodes before linearized reading' (duration: 556.008115ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:58:13.505005Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T11:58:12.948466Z","time spent":"556.531627ms","remote":"127.0.0.1:41438","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-06-15T11:58:13.504996Z","caller":"traceutil/trace.go:171","msg":"trace[534649794] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5666; }","duration":"382.964597ms","start":"2026-06-15T11:58:13.122002Z","end":"2026-06-15T11:58:13.504967Z","steps":["trace[534649794] 'agreement among raft nodes before linearized reading' (duration: 382.619429ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T11:58:13.505048Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T11:58:13.121984Z","time spent":"383.053239ms","remote":"127.0.0.1:41414","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":1,"response size":1888,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" "} {"level":"info","ts":"2026-06-15T11:59:04.199897Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3002} {"level":"info","ts":"2026-06-15T11:59:04.286554Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3002,"took":"84.829707ms","hash":2088375067,"current-db-size-bytes":57802752,"current-db-size":"58 MB","current-db-size-in-use-bytes":31735808,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-06-15T11:59:04.286653Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2088375067,"revision":3002,"compact-revision":-1} {"level":"info","ts":"2026-06-15T12:04:04.209266Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6098} {"level":"info","ts":"2026-06-15T12:04:04.342055Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6098,"took":"130.909032ms","hash":797596389,"current-db-size-bytes":57802752,"current-db-size":"58 MB","current-db-size-in-use-bytes":22065152,"current-db-size-in-use":"22 MB"} {"level":"info","ts":"2026-06-15T12:04:04.34215Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":797596389,"revision":6098,"compact-revision":3002} {"level":"info","ts":"2026-06-15T12:04:08.957021Z","caller":"traceutil/trace.go:171","msg":"trace[1255983825] transaction","detail":"{read_only:false; response_revision:8244; number_of_response:1; }","duration":"105.779878ms","start":"2026-06-15T12:04:08.851208Z","end":"2026-06-15T12:04:08.956988Z","steps":["trace[1255983825] 'process raft request' (duration: 105.587554ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T12:04:09.017652Z","caller":"traceutil/trace.go:171","msg":"trace[774974273] transaction","detail":"{read_only:false; response_revision:8246; number_of_response:1; }","duration":"153.581266ms","start":"2026-06-15T12:04:08.864031Z","end":"2026-06-15T12:04:09.017612Z","steps":["trace[774974273] 'process raft request' (duration: 153.515695ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T12:04:09.017789Z","caller":"traceutil/trace.go:171","msg":"trace[1872086276] transaction","detail":"{read_only:false; response_revision:8245; number_of_response:1; }","duration":"159.520318ms","start":"2026-06-15T12:04:08.858225Z","end":"2026-06-15T12:04:09.017745Z","steps":["trace[1872086276] 'process raft request' (duration: 159.106119ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T12:04:17.193842Z","caller":"traceutil/trace.go:171","msg":"trace[785615923] transaction","detail":"{read_only:false; response_revision:8417; number_of_response:1; }","duration":"203.639646ms","start":"2026-06-15T12:04:16.990172Z","end":"2026-06-15T12:04:17.193812Z","steps":["trace[785615923] 'process raft request' (duration: 203.425371ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T12:04:17.774096Z","caller":"traceutil/trace.go:171","msg":"trace[738123018] transaction","detail":"{read_only:false; response_revision:8418; number_of_response:1; }","duration":"722.454028ms","start":"2026-06-15T12:04:17.051601Z","end":"2026-06-15T12:04:17.774055Z","steps":["trace[738123018] 'process raft request' (duration: 722.205602ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T12:04:17.774169Z","caller":"traceutil/trace.go:171","msg":"trace[1252532967] transaction","detail":"{read_only:false; response_revision:8419; number_of_response:1; }","duration":"713.238767ms","start":"2026-06-15T12:04:17.060897Z","end":"2026-06-15T12:04:17.774136Z","steps":["trace[1252532967] 'process raft request' (duration: 713.094203ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T12:04:17.774281Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T12:04:17.051567Z","time spent":"722.618742ms","remote":"127.0.0.1:41510","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T12:04:17.774343Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T12:04:17.06087Z","time spent":"713.37652ms","remote":"127.0.0.1:41510","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":508,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T12:04:17.774366Z","caller":"traceutil/trace.go:171","msg":"trace[1357158348] linearizableReadLoop","detail":"{readStateIndex:8716; appliedIndex:8713; }","duration":"445.198254ms","start":"2026-06-15T12:04:17.329132Z","end":"2026-06-15T12:04:17.77433Z","steps":["trace[1357158348] 'read index received' (duration: 444.670452ms)","trace[1357158348] 'applied index is now lower than readState.Index' (duration: 526.492µs)"],"step_count":2} {"level":"info","ts":"2026-06-15T12:04:17.774426Z","caller":"traceutil/trace.go:171","msg":"trace[1326527740] transaction","detail":"{read_only:false; response_revision:8420; number_of_response:1; }","duration":"597.285024ms","start":"2026-06-15T12:04:17.17713Z","end":"2026-06-15T12:04:17.774415Z","steps":["trace[1326527740] 'process raft request' (duration: 596.907685ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T12:04:17.774473Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T12:04:17.177099Z","time spent":"597.349626ms","remote":"127.0.0.1:41432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":19522,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T12:04:17.774588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"445.456371ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.104\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-15T12:04:17.774629Z","caller":"traceutil/trace.go:171","msg":"trace[1193514622] range","detail":"{range_begin:/registry/masterleases/199.19.213.104; range_end:; response_count:1; response_revision:8420; }","duration":"445.544103ms","start":"2026-06-15T12:04:17.329072Z","end":"2026-06-15T12:04:17.774616Z","steps":["trace[1193514622] 'agreement among raft nodes before linearized reading' (duration: 445.378439ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T12:04:17.774676Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T12:04:17.329046Z","time spent":"445.622974ms","remote":"127.0.0.1:41278","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.19.213.104\" "} {"level":"warn","ts":"2026-06-15T12:04:17.778099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"370.484302ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-15T12:04:17.778196Z","caller":"traceutil/trace.go:171","msg":"trace[617981854] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8421; }","duration":"370.644865ms","start":"2026-06-15T12:04:17.407529Z","end":"2026-06-15T12:04:17.778174Z","steps":["trace[617981854] 'agreement among raft nodes before linearized reading' (duration: 370.320098ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T12:04:17.778182Z","caller":"traceutil/trace.go:171","msg":"trace[1172862507] transaction","detail":"{read_only:false; response_revision:8421; number_of_response:1; }","duration":"445.046621ms","start":"2026-06-15T12:04:17.333112Z","end":"2026-06-15T12:04:17.778158Z","steps":["trace[1172862507] 'process raft request' (duration: 444.480927ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T12:04:17.778249Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T12:04:17.407501Z","time spent":"370.739277ms","remote":"127.0.0.1:41510","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-15T12:04:17.778356Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T12:04:17.333075Z","time spent":"445.192565ms","remote":"127.0.0.1:41510","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-06-15T12:04:17.778366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.752696ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T12:04:17.77842Z","caller":"traceutil/trace.go:171","msg":"trace[858379455] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8421; }","duration":"167.864078ms","start":"2026-06-15T12:04:17.610541Z","end":"2026-06-15T12:04:17.778405Z","steps":["trace[858379455] 'agreement among raft nodes before linearized reading' (duration: 167.777326ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T12:04:17.778502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.973367ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-15T12:04:17.778528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.995417ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-06-15T12:04:17.778581Z","caller":"traceutil/trace.go:171","msg":"trace[608823982] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8421; }","duration":"232.09475ms","start":"2026-06-15T12:04:17.546474Z","end":"2026-06-15T12:04:17.778568Z","steps":["trace[608823982] 'agreement among raft nodes before linearized reading' (duration: 231.882355ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T12:04:17.778582Z","caller":"traceutil/trace.go:171","msg":"trace[817149597] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:8421; }","duration":"132.09152ms","start":"2026-06-15T12:04:17.646463Z","end":"2026-06-15T12:04:17.778555Z","steps":["trace[817149597] 'agreement among raft nodes before linearized reading' (duration: 131.931916ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T12:04:28.161316Z","caller":"traceutil/trace.go:171","msg":"trace[1755535905] transaction","detail":"{read_only:false; response_revision:8472; number_of_response:1; }","duration":"330.597564ms","start":"2026-06-15T12:04:27.83069Z","end":"2026-06-15T12:04:28.161287Z","steps":["trace[1755535905] 'process raft request' (duration: 330.42025ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T12:04:28.161495Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T12:04:27.830643Z","time spent":"330.755458ms","remote":"127.0.0.1:41510","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T12:04:28.170996Z","caller":"traceutil/trace.go:171","msg":"trace[92926651] linearizableReadLoop","detail":"{readStateIndex:8773; appliedIndex:8771; }","duration":"323.230497ms","start":"2026-06-15T12:04:27.847737Z","end":"2026-06-15T12:04:28.170968Z","steps":["trace[92926651] 'read index received' (duration: 313.540655ms)","trace[92926651] 'applied index is now lower than readState.Index' (duration: 9.688202ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T12:04:28.171078Z","caller":"traceutil/trace.go:171","msg":"trace[766996904] transaction","detail":"{read_only:false; response_revision:8473; number_of_response:1; }","duration":"330.41342ms","start":"2026-06-15T12:04:27.840639Z","end":"2026-06-15T12:04:28.171052Z","steps":["trace[766996904] 'process raft request' (duration: 330.123433ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T12:04:28.171173Z","caller":"traceutil/trace.go:171","msg":"trace[1320944459] transaction","detail":"{read_only:false; response_revision:8474; number_of_response:1; }","duration":"328.059173ms","start":"2026-06-15T12:04:27.843073Z","end":"2026-06-15T12:04:28.171132Z","steps":["trace[1320944459] 'process raft request' (duration: 327.850808ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T12:04:28.171214Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T12:04:27.840605Z","time spent":"330.543693ms","remote":"127.0.0.1:41510","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T12:04:28.171306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.022405ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-06-15T12:04:28.171311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.176633ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-k46bw\" ","response":"range_response_count:1 size:6451"} {"level":"info","ts":"2026-06-15T12:04:28.171345Z","caller":"traceutil/trace.go:171","msg":"trace[880459539] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8474; }","duration":"306.127657ms","start":"2026-06-15T12:04:27.865206Z","end":"2026-06-15T12:04:28.171334Z","steps":["trace[880459539] 'agreement among raft nodes before linearized reading' (duration: 305.971413ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T12:04:28.171352Z","caller":"traceutil/trace.go:171","msg":"trace[1699029573] range","detail":"{range_begin:/registry/pods/openstack/keepalived-k46bw; range_end:; response_count:1; response_revision:8474; }","duration":"297.298465ms","start":"2026-06-15T12:04:27.874045Z","end":"2026-06-15T12:04:28.171343Z","steps":["trace[1699029573] 'agreement among raft nodes before linearized reading' (duration: 297.139182ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T12:04:28.171338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.014669ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"warn","ts":"2026-06-15T12:04:28.171368Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T12:04:27.842996Z","time spent":"328.264208ms","remote":"127.0.0.1:41510","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-06-15T12:04:28.171384Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T12:04:27.865177Z","time spent":"306.198749ms","remote":"127.0.0.1:41510","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":"info","ts":"2026-06-15T12:04:28.17143Z","caller":"traceutil/trace.go:171","msg":"trace[562583890] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8474; }","duration":"312.142901ms","start":"2026-06-15T12:04:27.859267Z","end":"2026-06-15T12:04:28.171409Z","steps":["trace[562583890] 'agreement among raft nodes before linearized reading' (duration: 311.900365ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T12:04:28.171481Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T12:04:27.859255Z","time spent":"312.216674ms","remote":"127.0.0.1:41510","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-15T12:04:28.17162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.886583ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-06-15T12:04:28.171657Z","caller":"traceutil/trace.go:171","msg":"trace[1958535545] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8474; }","duration":"323.954675ms","start":"2026-06-15T12:04:27.847692Z","end":"2026-06-15T12:04:28.171646Z","steps":["trace[1958535545] 'agreement among raft nodes before linearized reading' (duration: 323.440072ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T12:04:28.171683Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T12:04:27.847677Z","time spent":"323.999796ms","remote":"127.0.0.1:41510","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-15T12:04:28.286629Z","caller":"traceutil/trace.go:171","msg":"trace[445301590] transaction","detail":"{read_only:false; response_revision:8476; number_of_response:1; }","duration":"110.220706ms","start":"2026-06-15T12:04:28.176387Z","end":"2026-06-15T12:04:28.286608Z","steps":["trace[445301590] 'process raft request' (duration: 110.124793ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T12:04:28.286634Z","caller":"traceutil/trace.go:171","msg":"trace[1373193137] transaction","detail":"{read_only:false; response_revision:8475; number_of_response:1; }","duration":"110.226355ms","start":"2026-06-15T12:04:28.176366Z","end":"2026-06-15T12:04:28.286593Z","steps":["trace[1373193137] 'process raft request' (duration: 109.925428ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T12:04:28.286587Z","caller":"traceutil/trace.go:171","msg":"trace[350048329] linearizableReadLoop","detail":"{readStateIndex:8775; appliedIndex:8773; }","duration":"109.452887ms","start":"2026-06-15T12:04:28.177115Z","end":"2026-06-15T12:04:28.286568Z","steps":["trace[350048329] 'read index received' (duration: 109.321303ms)","trace[350048329] 'applied index is now lower than readState.Index' (duration: 130.374µs)"],"step_count":2} {"level":"warn","ts":"2026-06-15T12:04:28.287191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.060432ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:26 size:230044"} {"level":"info","ts":"2026-06-15T12:04:28.287261Z","caller":"traceutil/trace.go:171","msg":"trace[761614651] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:26; response_revision:8476; }","duration":"110.200055ms","start":"2026-06-15T12:04:28.177047Z","end":"2026-06-15T12:04:28.287247Z","steps":["trace[761614651] 'agreement among raft nodes before linearized reading' (duration: 109.730194ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T12:04:28.313209Z","caller":"traceutil/trace.go:171","msg":"trace[463680208] transaction","detail":"{read_only:false; response_revision:8477; number_of_response:1; }","duration":"135.200414ms","start":"2026-06-15T12:04:28.177988Z","end":"2026-06-15T12:04:28.313188Z","steps":["trace[463680208] 'process raft request' (duration: 135.040041ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T12:04:29.422345Z","caller":"traceutil/trace.go:171","msg":"trace[401287441] linearizableReadLoop","detail":"{readStateIndex:8779; appliedIndex:8778; }","duration":"121.706981ms","start":"2026-06-15T12:04:29.30061Z","end":"2026-06-15T12:04:29.422317Z","steps":["trace[401287441] 'read index received' (duration: 121.376973ms)","trace[401287441] 'applied index is now lower than readState.Index' (duration: 328.788µs)"],"step_count":2} {"level":"info","ts":"2026-06-15T12:04:29.422451Z","caller":"traceutil/trace.go:171","msg":"trace[2133188811] transaction","detail":"{read_only:false; response_revision:8480; number_of_response:1; }","duration":"161.880046ms","start":"2026-06-15T12:04:29.260522Z","end":"2026-06-15T12:04:29.422402Z","steps":["trace[2133188811] 'process raft request' (duration: 161.607949ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T12:04:29.422511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.873575ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.carvel.dev/secretimports/\" range_end:\"/registry/secretgen.carvel.dev/secretimports0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T12:04:29.422562Z","caller":"traceutil/trace.go:171","msg":"trace[972460004] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secretimports/; range_end:/registry/secretgen.carvel.dev/secretimports0; response_count:0; response_revision:8480; }","duration":"121.994568ms","start":"2026-06-15T12:04:29.300553Z","end":"2026-06-15T12:04:29.422547Z","steps":["trace[972460004] 'agreement among raft nodes before linearized reading' (duration: 121.876705ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T12:04:30.44062Z","caller":"traceutil/trace.go:171","msg":"trace[909406106] transaction","detail":"{read_only:false; response_revision:8482; number_of_response:1; }","duration":"271.835904ms","start":"2026-06-15T12:04:30.168749Z","end":"2026-06-15T12:04:30.440585Z","steps":["trace[909406106] 'process raft request' (duration: 271.608948ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T12:04:30.509321Z","caller":"traceutil/trace.go:171","msg":"trace[240085124] linearizableReadLoop","detail":"{readStateIndex:8783; appliedIndex:8780; }","duration":"216.67677ms","start":"2026-06-15T12:04:30.292612Z","end":"2026-06-15T12:04:30.509288Z","steps":["trace[240085124] 'read index received' (duration: 147.739235ms)","trace[240085124] 'applied index is now lower than readState.Index' (duration: 68.936415ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T12:04:30.509375Z","caller":"traceutil/trace.go:171","msg":"trace[169546588] transaction","detail":"{read_only:false; response_revision:8483; number_of_response:1; }","duration":"331.129337ms","start":"2026-06-15T12:04:30.178205Z","end":"2026-06-15T12:04:30.509334Z","steps":["trace[169546588] 'process raft request' (duration: 330.83984ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T12:04:30.509424Z","caller":"traceutil/trace.go:171","msg":"trace[497833] transaction","detail":"{read_only:false; response_revision:8484; number_of_response:1; }","duration":"329.99961ms","start":"2026-06-15T12:04:30.179375Z","end":"2026-06-15T12:04:30.509375Z","steps":["trace[497833] 'process raft request' (duration: 329.856176ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T12:04:30.509556Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T12:04:30.17818Z","time spent":"331.279931ms","remote":"127.0.0.1:41510","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T12:04:30.509631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.994638ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-06-15T12:04:30.509644Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T12:04:30.179358Z","time spent":"330.168365ms","remote":"127.0.0.1:41510","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":508,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T12:04:30.509677Z","caller":"traceutil/trace.go:171","msg":"trace[1797272871] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8484; }","duration":"217.115311ms","start":"2026-06-15T12:04:30.292551Z","end":"2026-06-15T12:04:30.509666Z","steps":["trace[1797272871] 'agreement among raft nodes before linearized reading' (duration: 216.921866ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T12:04:30.50989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.432006ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-k46bw\" ","response":"range_response_count:1 size:6451"} {"level":"info","ts":"2026-06-15T12:04:30.509934Z","caller":"traceutil/trace.go:171","msg":"trace[1266662225] range","detail":"{range_begin:/registry/pods/openstack/keepalived-k46bw; range_end:; response_count:1; response_revision:8484; }","duration":"214.483108ms","start":"2026-06-15T12:04:30.295437Z","end":"2026-06-15T12:04:30.50992Z","steps":["trace[1266662225] 'agreement among raft nodes before linearized reading' (duration: 214.351345ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T12:04:30.5099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.737102ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-06-15T12:04:30.510035Z","caller":"traceutil/trace.go:171","msg":"trace[1095610870] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8484; }","duration":"216.896225ms","start":"2026-06-15T12:04:30.293122Z","end":"2026-06-15T12:04:30.510018Z","steps":["trace[1095610870] 'agreement among raft nodes before linearized reading' (duration: 216.595118ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T12:04:30.510011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.066354ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-06-15T12:04:30.510903Z","caller":"traceutil/trace.go:171","msg":"trace[1130666206] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8484; }","duration":"193.36588ms","start":"2026-06-15T12:04:30.316827Z","end":"2026-06-15T12:04:30.510193Z","steps":["trace[1130666206] 'agreement among raft nodes before linearized reading' (duration: 192.93713ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T12:04:30.646709Z","caller":"traceutil/trace.go:171","msg":"trace[1402965498] transaction","detail":"{read_only:false; response_revision:8485; number_of_response:1; }","duration":"130.881081ms","start":"2026-06-15T12:04:30.515797Z","end":"2026-06-15T12:04:30.646678Z","steps":["trace[1402965498] 'process raft request' (duration: 55.693277ms)","trace[1402965498] 'compare' (duration: 75.050181ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T12:04:30.731882Z","caller":"traceutil/trace.go:171","msg":"trace[995418320] transaction","detail":"{read_only:false; response_revision:8486; number_of_response:1; }","duration":"215.699757ms","start":"2026-06-15T12:04:30.516154Z","end":"2026-06-15T12:04:30.731853Z","steps":["trace[995418320] 'process raft request' (duration: 215.467632ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T12:04:30.732246Z","caller":"traceutil/trace.go:171","msg":"trace[470168012] linearizableReadLoop","detail":"{readStateIndex:8787; appliedIndex:8784; }","duration":"122.684004ms","start":"2026-06-15T12:04:30.609536Z","end":"2026-06-15T12:04:30.73222Z","steps":["trace[470168012] 'read index received' (duration: 122.017388ms)","trace[470168012] 'applied index is now lower than readState.Index' (duration: 665.636µs)"],"step_count":2} {"level":"info","ts":"2026-06-15T12:04:30.732234Z","caller":"traceutil/trace.go:171","msg":"trace[2113747463] transaction","detail":"{read_only:false; response_revision:8487; number_of_response:1; }","duration":"215.360158ms","start":"2026-06-15T12:04:30.516834Z","end":"2026-06-15T12:04:30.732194Z","steps":["trace[2113747463] 'process raft request' (duration: 214.965269ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T12:04:30.732366Z","caller":"traceutil/trace.go:171","msg":"trace[1154140149] transaction","detail":"{read_only:false; response_revision:8488; number_of_response:1; }","duration":"212.48244ms","start":"2026-06-15T12:04:30.519869Z","end":"2026-06-15T12:04:30.732351Z","steps":["trace[1154140149] 'process raft request' (duration: 212.228494ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T12:04:30.732566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.015243ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T12:04:30.732603Z","caller":"traceutil/trace.go:171","msg":"trace[786508638] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8488; }","duration":"123.118675ms","start":"2026-06-15T12:04:30.609475Z","end":"2026-06-15T12:04:30.732594Z","steps":["trace[786508638] 'agreement among raft nodes before linearized reading' (duration: 123.044173ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T12:04:31.850975Z","caller":"traceutil/trace.go:171","msg":"trace[1943842243] transaction","detail":"{read_only:false; response_revision:8490; number_of_response:1; }","duration":"423.250418ms","start":"2026-06-15T12:04:31.427687Z","end":"2026-06-15T12:04:31.850938Z","steps":["trace[1943842243] 'process raft request' (duration: 423.061993ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T12:04:31.85143Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T12:04:31.427653Z","time spent":"423.671868ms","remote":"127.0.0.1:41510","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-06-15T12:04:32.760291Z","caller":"traceutil/trace.go:171","msg":"trace[378900918] linearizableReadLoop","detail":"{readStateIndex:8792; appliedIndex:8790; }","duration":"235.470802ms","start":"2026-06-15T12:04:32.524791Z","end":"2026-06-15T12:04:32.760262Z","steps":["trace[378900918] 'read index received' (duration: 20.787399ms)","trace[378900918] 'applied index is now lower than readState.Index' (duration: 214.682073ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T12:04:32.760448Z","caller":"traceutil/trace.go:171","msg":"trace[376084828] transaction","detail":"{read_only:false; response_revision:8493; number_of_response:1; }","duration":"244.647962ms","start":"2026-06-15T12:04:32.515751Z","end":"2026-06-15T12:04:32.760399Z","steps":["trace[376084828] 'process raft request' (duration: 244.286063ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T12:04:32.760558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.187999ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T12:04:32.760647Z","caller":"traceutil/trace.go:171","msg":"trace[404338274] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8493; }","duration":"151.343682ms","start":"2026-06-15T12:04:32.609284Z","end":"2026-06-15T12:04:32.760628Z","steps":["trace[404338274] 'agreement among raft nodes before linearized reading' (duration: 151.181379ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T12:04:32.760649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.828ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-k46bw\" ","response":"range_response_count:1 size:6451"} {"level":"info","ts":"2026-06-15T12:04:32.760694Z","caller":"traceutil/trace.go:171","msg":"trace[1186639618] range","detail":"{range_begin:/registry/pods/openstack/keepalived-k46bw; range_end:; response_count:1; response_revision:8493; }","duration":"235.951453ms","start":"2026-06-15T12:04:32.52473Z","end":"2026-06-15T12:04:32.760682Z","steps":["trace[1186639618] 'agreement among raft nodes before linearized reading' (duration: 235.722827ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T12:04:32.760886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.971765ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-15T12:04:32.76098Z","caller":"traceutil/trace.go:171","msg":"trace[974104791] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8493; }","duration":"109.120078ms","start":"2026-06-15T12:04:32.65184Z","end":"2026-06-15T12:04:32.76096Z","steps":["trace[974104791] 'agreement among raft nodes before linearized reading' (duration: 108.955894ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T12:04:33.064801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.861037ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-15T12:04:33.065071Z","caller":"traceutil/trace.go:171","msg":"trace[895551156] linearizableReadLoop","detail":"{readStateIndex:8794; appliedIndex:8792; }","duration":"299.076348ms","start":"2026-06-15T12:04:32.765974Z","end":"2026-06-15T12:04:33.06505Z","steps":["trace[895551156] 'read index received' (duration: 83.787861ms)","trace[895551156] 'applied index is now lower than readState.Index' (duration: 215.287017ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T12:04:33.065114Z","caller":"traceutil/trace.go:171","msg":"trace[1278767242] transaction","detail":"{read_only:false; response_revision:8497; number_of_response:1; }","duration":"298.72389ms","start":"2026-06-15T12:04:32.766372Z","end":"2026-06-15T12:04:33.065096Z","steps":["trace[1278767242] 'process raft request' (duration: 298.640958ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T12:04:33.065114Z","caller":"traceutil/trace.go:171","msg":"trace[192098368] transaction","detail":"{read_only:false; response_revision:8495; number_of_response:1; }","duration":"299.898047ms","start":"2026-06-15T12:04:32.765181Z","end":"2026-06-15T12:04:33.065079Z","steps":["trace[192098368] 'process raft request' (duration: 299.740674ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T12:04:33.065168Z","caller":"traceutil/trace.go:171","msg":"trace[1118558469] transaction","detail":"{read_only:false; response_revision:8496; number_of_response:1; }","duration":"299.138289ms","start":"2026-06-15T12:04:32.765976Z","end":"2026-06-15T12:04:33.065114Z","steps":["trace[1118558469] 'process raft request' (duration: 298.996346ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T12:04:33.065181Z","caller":"traceutil/trace.go:171","msg":"trace[177133135] transaction","detail":"{read_only:false; response_revision:8494; number_of_response:1; }","duration":"300.034911ms","start":"2026-06-15T12:04:32.765092Z","end":"2026-06-15T12:04:33.065127Z","steps":["trace[177133135] 'process raft request' (duration: 84.731543ms)","trace[177133135] 'compare' (duration: 214.732244ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T12:04:33.065264Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T12:04:32.765167Z","time spent":"300.010651ms","remote":"127.0.0.1:41510","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-06-15T12:04:33.065431Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T12:04:32.765071Z","time spent":"300.224996ms","remote":"127.0.0.1:41510","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T12:04:33.065608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.60864ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:26 size:230044"} {"level":"info","ts":"2026-06-15T12:04:33.065673Z","caller":"traceutil/trace.go:171","msg":"trace[1039900313] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:26; response_revision:8497; }","duration":"299.716003ms","start":"2026-06-15T12:04:32.765943Z","end":"2026-06-15T12:04:33.065659Z","steps":["trace[1039900313] 'agreement among raft nodes before linearized reading' (duration: 299.187601ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T12:04:33.322236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.039887ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-06-15T12:04:33.322367Z","caller":"traceutil/trace.go:171","msg":"trace[471863067] linearizableReadLoop","detail":"{readStateIndex:8797; appliedIndex:8796; }","duration":"257.236934ms","start":"2026-06-15T12:04:33.065109Z","end":"2026-06-15T12:04:33.322346Z","steps":["trace[471863067] 'read index received' (duration: 33.050683ms)","trace[471863067] 'applied index is now lower than readState.Index' (duration: 224.184611ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T12:04:33.322574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"536.962567ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-06-15T12:04:33.322553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.032111ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T12:04:33.322647Z","caller":"traceutil/trace.go:171","msg":"trace[1443025455] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:8497; }","duration":"260.187454ms","start":"2026-06-15T12:04:33.062437Z","end":"2026-06-15T12:04:33.322625Z","steps":["trace[1443025455] 'agreement among raft nodes before linearized reading' (duration: 260.02518ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T12:04:33.32265Z","caller":"traceutil/trace.go:171","msg":"trace[762723316] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8497; }","duration":"537.032679ms","start":"2026-06-15T12:04:32.78558Z","end":"2026-06-15T12:04:33.322612Z","steps":["trace[762723316] 'agreement among raft nodes before linearized reading' (duration: 536.819874ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T12:04:33.322715Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T12:04:32.785525Z","time spent":"537.168782ms","remote":"127.0.0.1:41510","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-15T12:04:33.627662Z","caller":"traceutil/trace.go:171","msg":"trace[1816605646] transaction","detail":"{read_only:false; response_revision:8498; number_of_response:1; }","duration":"298.912094ms","start":"2026-06-15T12:04:33.328689Z","end":"2026-06-15T12:04:33.627602Z","steps":["trace[1816605646] 'process raft request' (duration: 298.529864ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T12:04:59.385435Z","caller":"traceutil/trace.go:171","msg":"trace[675219869] linearizableReadLoop","detail":"{readStateIndex:8950; appliedIndex:8949; }","duration":"104.008008ms","start":"2026-06-15T12:04:59.281387Z","end":"2026-06-15T12:04:59.385395Z","steps":["trace[675219869] 'read index received' (duration: 98.469396ms)","trace[675219869] 'applied index is now lower than readState.Index' (duration: 5.536592ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T12:04:59.385675Z","caller":"traceutil/trace.go:171","msg":"trace[104284769] transaction","detail":"{read_only:false; response_revision:8645; number_of_response:1; }","duration":"106.167469ms","start":"2026-06-15T12:04:59.279478Z","end":"2026-06-15T12:04:59.385646Z","steps":["trace[104284769] 'process raft request' (duration: 100.450612ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T12:04:59.385921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.311945ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/openstack/rook-ceph-rgw\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T12:04:59.386003Z","caller":"traceutil/trace.go:171","msg":"trace[417595809] range","detail":"{range_begin:/registry/serviceaccounts/openstack/rook-ceph-rgw; range_end:; response_count:0; response_revision:8645; }","duration":"104.644603ms","start":"2026-06-15T12:04:59.281339Z","end":"2026-06-15T12:04:59.385984Z","steps":["trace[417595809] 'agreement among raft nodes before linearized reading' (duration: 104.285184ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T12:05:00.161636Z","caller":"traceutil/trace.go:171","msg":"trace[1222143868] linearizableReadLoop","detail":"{readStateIndex:8981; appliedIndex:8978; }","duration":"163.990422ms","start":"2026-06-15T12:04:59.997619Z","end":"2026-06-15T12:05:00.161609Z","steps":["trace[1222143868] 'read index received' (duration: 89.872659ms)","trace[1222143868] 'applied index is now lower than readState.Index' (duration: 74.116763ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T12:05:00.161769Z","caller":"traceutil/trace.go:171","msg":"trace[1551975147] transaction","detail":"{read_only:false; response_revision:8674; number_of_response:1; }","duration":"181.383737ms","start":"2026-06-15T12:04:59.980372Z","end":"2026-06-15T12:05:00.161756Z","steps":["trace[1551975147] 'process raft request' (duration: 181.149612ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T12:05:00.161871Z","caller":"traceutil/trace.go:171","msg":"trace[1744842050] transaction","detail":"{read_only:false; response_revision:8673; number_of_response:1; }","duration":"185.833284ms","start":"2026-06-15T12:04:59.975993Z","end":"2026-06-15T12:05:00.161826Z","steps":["trace[1744842050] 'process raft request' (duration: 185.380353ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T12:05:00.161932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.087553ms","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-06-15T12:05:00.161988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.187501ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/rook-ceph/rook-ceph-operator-76bbbb77ff\" ","response":"range_response_count:1 size:4087"} {"level":"info","ts":"2026-06-15T12:05:00.162001Z","caller":"traceutil/trace.go:171","msg":"trace[1271694788] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:8674; }","duration":"169.187795ms","start":"2026-06-15T12:04:59.992792Z","end":"2026-06-15T12:05:00.161979Z","steps":["trace[1271694788] 'agreement among raft nodes before linearized reading' (duration: 169.037672ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T12:05:00.16206Z","caller":"traceutil/trace.go:171","msg":"trace[2020423326] range","detail":"{range_begin:/registry/replicasets/rook-ceph/rook-ceph-operator-76bbbb77ff; range_end:; response_count:1; response_revision:8674; }","duration":"191.360236ms","start":"2026-06-15T12:04:59.970678Z","end":"2026-06-15T12:05:00.162038Z","steps":["trace[2020423326] 'agreement among raft nodes before linearized reading' (duration: 191.156241ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T12:05:00.167677Z","caller":"traceutil/trace.go:171","msg":"trace[1899173466] transaction","detail":"{read_only:false; response_revision:8675; number_of_response:1; }","duration":"165.674951ms","start":"2026-06-15T12:05:00.001934Z","end":"2026-06-15T12:05:00.167609Z","steps":["trace[1899173466] 'process raft request' (duration: 165.463536ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T12:05:00.167762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.207854ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclusters/openstack/ceph\" ","response":"range_response_count:1 size:5146"} {"level":"info","ts":"2026-06-15T12:05:00.167816Z","caller":"traceutil/trace.go:171","msg":"trace[1494293169] range","detail":"{range_begin:/registry/ceph.rook.io/cephclusters/openstack/ceph; range_end:; response_count:1; response_revision:8677; }","duration":"161.296657ms","start":"2026-06-15T12:05:00.006505Z","end":"2026-06-15T12:05:00.167802Z","steps":["trace[1494293169] 'agreement among raft nodes before linearized reading' (duration: 161.124583ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T12:05:00.168018Z","caller":"traceutil/trace.go:171","msg":"trace[1665959858] transaction","detail":"{read_only:false; response_revision:8676; number_of_response:1; }","duration":"163.742895ms","start":"2026-06-15T12:05:00.004236Z","end":"2026-06-15T12:05:00.167979Z","steps":["trace[1665959858] 'process raft request' (duration: 163.288644ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T12:05:01.719572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.546666ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-15T12:05:01.719694Z","caller":"traceutil/trace.go:171","msg":"trace[1791421680] linearizableReadLoop","detail":"{readStateIndex:9008; appliedIndex:9007; }","duration":"300.000505ms","start":"2026-06-15T12:05:01.419672Z","end":"2026-06-15T12:05:01.719672Z","steps":["trace[1791421680] 'read index received' (duration: 84.283016ms)","trace[1791421680] 'applied index is now lower than readState.Index' (duration: 215.715859ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T12:05:01.719804Z","caller":"traceutil/trace.go:171","msg":"trace[1888492803] transaction","detail":"{read_only:false; response_revision:8700; number_of_response:1; }","duration":"300.837186ms","start":"2026-06-15T12:05:01.418954Z","end":"2026-06-15T12:05:01.719792Z","steps":["trace[1888492803] 'process raft request' (duration: 84.975813ms)","trace[1888492803] 'compare' (duration: 215.235008ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T12:05:01.719873Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T12:05:01.418925Z","time spent":"300.913957ms","remote":"127.0.0.1:41510","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-06-15T12:05:01.719914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.807916ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T12:05:01.720009Z","caller":"traceutil/trace.go:171","msg":"trace[1831024818] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8700; }","duration":"109.942779ms","start":"2026-06-15T12:05:01.610043Z","end":"2026-06-15T12:05:01.719986Z","steps":["trace[1831024818] 'agreement among raft nodes before linearized reading' (duration: 109.797136ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T12:05:01.720061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.51343ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-06-15T12:05:01.720153Z","caller":"traceutil/trace.go:171","msg":"trace[1945320599] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8700; }","duration":"270.640203ms","start":"2026-06-15T12:05:01.449492Z","end":"2026-06-15T12:05:01.720133Z","steps":["trace[1945320599] 'agreement among raft nodes before linearized reading' (duration: 270.351056ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T12:05:01.720202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.605749ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/rook-ceph/csi-rbdplugin-metrics\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T12:05:01.720295Z","caller":"traceutil/trace.go:171","msg":"trace[1480243888] range","detail":"{range_begin:/registry/services/specs/rook-ceph/csi-rbdplugin-metrics; range_end:; response_count:0; response_revision:8700; }","duration":"157.736353ms","start":"2026-06-15T12:05:01.562531Z","end":"2026-06-15T12:05:01.720268Z","steps":["trace[1480243888] 'agreement among raft nodes before linearized reading' (duration: 157.59843ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T12:05:01.720351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.647051ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-k46bw\" ","response":"range_response_count:1 size:6451"} {"level":"warn","ts":"2026-06-15T12:05:01.720374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.20312ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-6xvbt\" ","response":"range_response_count:1 size:4455"} {"level":"info","ts":"2026-06-15T12:05:01.72049Z","caller":"traceutil/trace.go:171","msg":"trace[784089518] range","detail":"{range_begin:/registry/pods/openstack/keepalived-k46bw; range_end:; response_count:1; response_revision:8700; }","duration":"300.819645ms","start":"2026-06-15T12:05:01.419644Z","end":"2026-06-15T12:05:01.720464Z","steps":["trace[784089518] 'agreement among raft nodes before linearized reading' (duration: 300.480547ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T12:05:01.720526Z","caller":"traceutil/trace.go:171","msg":"trace[862807188] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-6xvbt; range_end:; response_count:1; response_revision:8700; }","duration":"147.352965ms","start":"2026-06-15T12:05:01.573113Z","end":"2026-06-15T12:05:01.720466Z","steps":["trace[862807188] 'agreement among raft nodes before linearized reading' (duration: 147.015087ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T12:05:01.720555Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T12:05:01.419632Z","time spent":"300.907087ms","remote":"127.0.0.1:41438","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6474,"request content":"key:\"/registry/pods/openstack/keepalived-k46bw\" "} {"level":"warn","ts":"2026-06-15T12:05:06.065265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"657.71791ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/barbican-api-786bf748fc-ggdfr.18b93f9701b33213\" ","response":"range_response_count:1 size:1135"} {"level":"info","ts":"2026-06-15T12:05:06.065365Z","caller":"traceutil/trace.go:171","msg":"trace[2055766175] range","detail":"{range_begin:/registry/events/openstack/barbican-api-786bf748fc-ggdfr.18b93f9701b33213; range_end:; response_count:1; response_revision:8719; }","duration":"657.923066ms","start":"2026-06-15T12:05:05.407416Z","end":"2026-06-15T12:05:06.065339Z","steps":["trace[2055766175] 'range keys from in-memory index tree' (duration: 657.489105ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T12:05:06.065412Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T12:05:05.407384Z","time spent":"658.017807ms","remote":"127.0.0.1:41326","response type":"/etcdserverpb.KV/Range","request count":0,"request size":75,"response count":1,"response size":1158,"request content":"key:\"/registry/events/openstack/barbican-api-786bf748fc-ggdfr.18b93f9701b33213\" "} {"level":"warn","ts":"2026-06-15T12:05:06.065466Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.371732ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-15T12:05:06.065699Z","caller":"traceutil/trace.go:171","msg":"trace[1811310527] linearizableReadLoop","detail":"{readStateIndex:9029; appliedIndex:9028; }","duration":"458.007745ms","start":"2026-06-15T12:05:05.607666Z","end":"2026-06-15T12:05:06.065674Z","steps":["trace[1811310527] 'read index received' (duration: 252.300745ms)","trace[1811310527] 'applied index is now lower than readState.Index' (duration: 205.70529ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T12:05:06.066058Z","caller":"traceutil/trace.go:171","msg":"trace[754885222] transaction","detail":"{read_only:false; response_revision:8720; number_of_response:1; }","duration":"590.223786ms","start":"2026-06-15T12:05:05.475811Z","end":"2026-06-15T12:05:06.066035Z","steps":["trace[754885222] 'process raft request' (duration: 384.192759ms)","trace[754885222] 'compare' (duration: 205.230128ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T12:05:06.066157Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T12:05:05.475778Z","time spent":"590.325799ms","remote":"127.0.0.1:41510","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T12:05:06.065324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"646.376589ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-15T12:05:06.066365Z","caller":"traceutil/trace.go:171","msg":"trace[147614020] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8719; }","duration":"647.470786ms","start":"2026-06-15T12:05:05.418874Z","end":"2026-06-15T12:05:06.066345Z","steps":["trace[147614020] 'range keys from in-memory index tree' (duration: 646.203445ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T12:05:06.066404Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T12:05:05.418854Z","time spent":"647.541197ms","remote":"127.0.0.1:41510","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-15T12:05:06.066415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.662783ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-06-15T12:05:06.066463Z","caller":"traceutil/trace.go:171","msg":"trace[187792700] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8720; }","duration":"293.761956ms","start":"2026-06-15T12:05:05.772689Z","end":"2026-06-15T12:05:06.066451Z","steps":["trace[187792700] 'agreement among raft nodes before linearized reading' (duration: 293.598702ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T12:05:06.066609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.997269ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-06-15T12:05:06.066634Z","caller":"traceutil/trace.go:171","msg":"trace[1475237148] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8720; }","duration":"283.035979ms","start":"2026-06-15T12:05:05.783589Z","end":"2026-06-15T12:05:06.066625Z","steps":["trace[1475237148] 'agreement among raft nodes before linearized reading' (duration: 282.958657ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T12:05:06.066768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.630684ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-k46bw\" ","response":"range_response_count:1 size:6451"} {"level":"warn","ts":"2026-06-15T12:05:06.066781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"459.125941ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T12:05:06.066811Z","caller":"traceutil/trace.go:171","msg":"trace[1120868244] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8720; }","duration":"459.212713ms","start":"2026-06-15T12:05:05.607589Z","end":"2026-06-15T12:05:06.066802Z","steps":["trace[1120868244] 'agreement among raft nodes before linearized reading' (duration: 459.162661ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T12:05:06.06683Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T12:05:05.607557Z","time spent":"459.269304ms","remote":"127.0.0.1:41236","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-15T12:05:06.066791Z","caller":"traceutil/trace.go:171","msg":"trace[592779096] range","detail":"{range_begin:/registry/pods/openstack/keepalived-k46bw; range_end:; response_count:1; response_revision:8720; }","duration":"283.696095ms","start":"2026-06-15T12:05:05.783088Z","end":"2026-06-15T12:05:06.066784Z","steps":["trace[592779096] 'agreement among raft nodes before linearized reading' (duration: 283.611973ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T12:05:06.279663Z","caller":"traceutil/trace.go:171","msg":"trace[239030889] transaction","detail":"{read_only:false; response_revision:8721; number_of_response:1; }","duration":"210.866093ms","start":"2026-06-15T12:05:06.068767Z","end":"2026-06-15T12:05:06.279633Z","steps":["trace[239030889] 'process raft request' (duration: 200.346401ms)","trace[239030889] 'compare' (duration: 10.323367ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T12:05:06.289664Z","caller":"traceutil/trace.go:171","msg":"trace[1428672415] transaction","detail":"{read_only:false; response_revision:8722; number_of_response:1; }","duration":"218.66059ms","start":"2026-06-15T12:05:06.070947Z","end":"2026-06-15T12:05:06.289607Z","steps":["trace[1428672415] 'process raft request' (duration: 218.439014ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T12:05:06.289943Z","caller":"traceutil/trace.go:171","msg":"trace[794828671] transaction","detail":"{read_only:false; response_revision:8723; number_of_response:1; }","duration":"218.085666ms","start":"2026-06-15T12:05:06.071831Z","end":"2026-06-15T12:05:06.289917Z","steps":["trace[794828671] 'process raft request' (duration: 217.729347ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T12:05:06.292401Z","caller":"traceutil/trace.go:171","msg":"trace[186072103] transaction","detail":"{read_only:false; response_revision:8724; number_of_response:1; }","duration":"219.816067ms","start":"2026-06-15T12:05:06.072538Z","end":"2026-06-15T12:05:06.292355Z","steps":["trace[186072103] 'process raft request' (duration: 217.221265ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T12:05:06.292561Z","caller":"traceutil/trace.go:171","msg":"trace[1307001426] transaction","detail":"{read_only:false; response_revision:8725; number_of_response:1; }","duration":"218.717231ms","start":"2026-06-15T12:05:06.073818Z","end":"2026-06-15T12:05:06.292535Z","steps":["trace[1307001426] 'process raft request' (duration: 218.453444ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T12:05:06.29272Z","caller":"traceutil/trace.go:171","msg":"trace[2098807842] linearizableReadLoop","detail":"{readStateIndex:9031; appliedIndex:9029; }","duration":"220.924954ms","start":"2026-06-15T12:05:06.071778Z","end":"2026-06-15T12:05:06.292702Z","steps":["trace[2098807842] 'read index received' (duration: 197.407681ms)","trace[2098807842] 'applied index is now lower than readState.Index' (duration: 23.516273ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T12:05:06.293199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.397935ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:27 size:234775"} {"level":"info","ts":"2026-06-15T12:05:06.293294Z","caller":"traceutil/trace.go:171","msg":"trace[216550545] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:27; response_revision:8726; }","duration":"221.527419ms","start":"2026-06-15T12:05:06.071754Z","end":"2026-06-15T12:05:06.293282Z","steps":["trace[216550545] 'agreement among raft nodes before linearized reading' (duration: 221.051437ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T12:05:08.7579Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.685233ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T12:05:08.757992Z","caller":"traceutil/trace.go:171","msg":"trace[2001879614] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8738; }","duration":"147.888608ms","start":"2026-06-15T12:05:08.610085Z","end":"2026-06-15T12:05:08.757973Z","steps":["trace[2001879614] 'range keys from in-memory index tree' (duration: 147.57933ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T12:05:08.847092Z","caller":"traceutil/trace.go:171","msg":"trace[103376766] transaction","detail":"{read_only:false; response_revision:8739; number_of_response:1; }","duration":"170.718552ms","start":"2026-06-15T12:05:08.676263Z","end":"2026-06-15T12:05:08.846981Z","steps":["trace[103376766] 'process raft request' (duration: 170.479667ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T12:05:08.966474Z","caller":"traceutil/trace.go:171","msg":"trace[1805605728] transaction","detail":"{read_only:false; response_revision:8740; number_of_response:1; }","duration":"173.345957ms","start":"2026-06-15T12:05:08.793094Z","end":"2026-06-15T12:05:08.96644Z","steps":["trace[1805605728] 'process raft request' (duration: 135.257585ms)","trace[1805605728] 'compare' (duration: 37.795745ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T12:05:10.163937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"499.058776ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/nfd.k8s-sigs.io/nodefeatures/\" range_end:\"/registry/nfd.k8s-sigs.io/nodefeatures0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-15T12:05:10.164046Z","caller":"traceutil/trace.go:171","msg":"trace[1252008044] range","detail":"{range_begin:/registry/nfd.k8s-sigs.io/nodefeatures/; range_end:/registry/nfd.k8s-sigs.io/nodefeatures0; response_count:0; response_revision:8743; }","duration":"499.22751ms","start":"2026-06-15T12:05:09.664794Z","end":"2026-06-15T12:05:10.164021Z","steps":["trace[1252008044] 'count revisions from in-memory index tree' (duration: 498.948963ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T12:05:10.16409Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T12:05:09.664768Z","time spent":"499.310202ms","remote":"127.0.0.1:36430","response type":"/etcdserverpb.KV/Range","request count":0,"request size":84,"response count":1,"response size":30,"request content":"key:\"/registry/nfd.k8s-sigs.io/nodefeatures/\" range_end:\"/registry/nfd.k8s-sigs.io/nodefeatures0\" count_only:true "} {"level":"info","ts":"2026-06-15T12:05:10.569607Z","caller":"traceutil/trace.go:171","msg":"trace[684277476] linearizableReadLoop","detail":"{readStateIndex:9054; appliedIndex:9053; }","duration":"200.553166ms","start":"2026-06-15T12:05:10.369023Z","end":"2026-06-15T12:05:10.569577Z","steps":["trace[684277476] 'read index received' (duration: 200.494985ms)","trace[684277476] 'applied index is now lower than readState.Index' (duration: 56.731µs)"],"step_count":2} {"level":"info","ts":"2026-06-15T12:05:10.569721Z","caller":"traceutil/trace.go:171","msg":"trace[589884378] transaction","detail":"{read_only:false; response_revision:8744; number_of_response:1; }","duration":"273.46261ms","start":"2026-06-15T12:05:10.296221Z","end":"2026-06-15T12:05:10.569684Z","steps":["trace[589884378] 'process raft request' (duration: 273.121382ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T12:05:10.569931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.883125ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-06-15T12:05:10.570017Z","caller":"traceutil/trace.go:171","msg":"trace[702793459] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8744; }","duration":"201.035698ms","start":"2026-06-15T12:05:10.368962Z","end":"2026-06-15T12:05:10.569997Z","steps":["trace[702793459] 'agreement among raft nodes before linearized reading' (duration: 200.758312ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T12:05:10.599829Z","caller":"traceutil/trace.go:171","msg":"trace[1785736851] transaction","detail":"{read_only:false; response_revision:8745; number_of_response:1; }","duration":"203.753543ms","start":"2026-06-15T12:05:10.396043Z","end":"2026-06-15T12:05:10.599797Z","steps":["trace[1785736851] 'process raft request' (duration: 203.487187ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T12:05:10.599964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.60977ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-15T12:05:10.600039Z","caller":"traceutil/trace.go:171","msg":"trace[871179830] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8745; }","duration":"101.759143ms","start":"2026-06-15T12:05:10.498262Z","end":"2026-06-15T12:05:10.600021Z","steps":["trace[871179830] 'agreement among raft nodes before linearized reading' (duration: 101.504797ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T12:05:10.600094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.625712ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-06-15T12:05:10.600187Z","caller":"traceutil/trace.go:171","msg":"trace[1258728837] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8745; }","duration":"196.755856ms","start":"2026-06-15T12:05:10.40341Z","end":"2026-06-15T12:05:10.600166Z","steps":["trace[1258728837] 'agreement among raft nodes before linearized reading' (duration: 196.559731ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T12:05:10.600166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.789902ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-15T12:05:10.600273Z","caller":"traceutil/trace.go:171","msg":"trace[1402917745] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8745; }","duration":"205.968116ms","start":"2026-06-15T12:05:10.39428Z","end":"2026-06-15T12:05:10.600248Z","steps":["trace[1402917745] 'agreement among raft nodes before linearized reading' (duration: 205.604427ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T12:05:10.871593Z","caller":"traceutil/trace.go:171","msg":"trace[736749839] linearizableReadLoop","detail":"{readStateIndex:9056; appliedIndex:9055; }","duration":"271.863971ms","start":"2026-06-15T12:05:10.599697Z","end":"2026-06-15T12:05:10.871561Z","steps":["trace[736749839] 'read index received' (duration: 181.404147ms)","trace[736749839] 'applied index is now lower than readState.Index' (duration: 90.457924ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T12:05:10.871636Z","caller":"traceutil/trace.go:171","msg":"trace[823040049] transaction","detail":"{read_only:false; response_revision:8746; number_of_response:1; }","duration":"296.589072ms","start":"2026-06-15T12:05:10.57502Z","end":"2026-06-15T12:05:10.871609Z","steps":["trace[823040049] 'process raft request' (duration: 206.111558ms)","trace[823040049] 'compare' (duration: 90.175227ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T12:05:10.871855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.487518ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/ceph.18b93fa3c8f9bd47\" ","response":"range_response_count:1 size:699"} {"level":"info","ts":"2026-06-15T12:05:10.871914Z","caller":"traceutil/trace.go:171","msg":"trace[1946582326] range","detail":"{range_begin:/registry/events/openstack/ceph.18b93fa3c8f9bd47; range_end:; response_count:1; response_revision:8746; }","duration":"293.595661ms","start":"2026-06-15T12:05:10.578305Z","end":"2026-06-15T12:05:10.871901Z","steps":["trace[1946582326] 'agreement among raft nodes before linearized reading' (duration: 293.402087ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T12:05:11.296474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.422925ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-15T12:05:11.297038Z","caller":"traceutil/trace.go:171","msg":"trace[1397132417] transaction","detail":"{read_only:false; response_revision:8748; number_of_response:1; }","duration":"692.521382ms","start":"2026-06-15T12:05:10.604495Z","end":"2026-06-15T12:05:11.297016Z","steps":["trace[1397132417] 'process raft request' (duration: 692.120792ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T12:05:11.297139Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T12:05:10.604476Z","time spent":"692.622425ms","remote":"127.0.0.1:41510","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-06-15T12:05:11.29714Z","caller":"traceutil/trace.go:171","msg":"trace[1605806817] transaction","detail":"{read_only:false; response_revision:8747; number_of_response:1; }","duration":"693.117886ms","start":"2026-06-15T12:05:10.603968Z","end":"2026-06-15T12:05:11.297085Z","steps":["trace[1605806817] 'process raft request' (duration: 470.959233ms)","trace[1605806817] 'compare' (duration: 220.945124ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T12:05:11.297271Z","caller":"traceutil/trace.go:171","msg":"trace[1187228181] transaction","detail":"{read_only:false; response_revision:8749; number_of_response:1; }","duration":"691.032097ms","start":"2026-06-15T12:05:10.606203Z","end":"2026-06-15T12:05:11.297235Z","steps":["trace[1187228181] 'process raft request' (duration: 690.75593ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T12:05:11.297323Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T12:05:10.603934Z","time spent":"693.288861ms","remote":"127.0.0.1:41510","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T12:05:11.297445Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T12:05:10.606185Z","time spent":"691.16247ms","remote":"127.0.0.1:41510","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T12:05:11.436585Z","caller":"traceutil/trace.go:171","msg":"trace[1145759468] linearizableReadLoop","detail":"{readStateIndex:9060; appliedIndex:9056; }","duration":"564.87701ms","start":"2026-06-15T12:05:10.87168Z","end":"2026-06-15T12:05:11.436557Z","steps":["trace[1145759468] 'read index received' (duration: 203.267611ms)","trace[1145759468] 'applied index is now lower than readState.Index' (duration: 361.607939ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T12:05:11.436868Z","caller":"traceutil/trace.go:171","msg":"trace[1689884082] transaction","detail":"{read_only:false; response_revision:8753; number_of_response:1; }","duration":"389.524216ms","start":"2026-06-15T12:05:11.047322Z","end":"2026-06-15T12:05:11.436846Z","steps":["trace[1689884082] 'process raft request' (duration: 389.184768ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T12:05:11.437009Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T12:05:11.047287Z","time spent":"389.643139ms","remote":"127.0.0.1:41510","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T12:05:11.437291Z","caller":"traceutil/trace.go:171","msg":"trace[1778340678] transaction","detail":"{read_only:false; response_revision:8750; number_of_response:1; }","duration":"583.729951ms","start":"2026-06-15T12:05:10.853549Z","end":"2026-06-15T12:05:11.437279Z","steps":["trace[1778340678] 'process raft request' (duration: 572.468062ms)","trace[1778340678] 'compare' (duration: 10.232045ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T12:05:11.43748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"832.552341ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:27 size:234775"} {"level":"warn","ts":"2026-06-15T12:05:11.437515Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T12:05:10.85352Z","time spent":"583.962157ms","remote":"127.0.0.1:41510","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T12:05:11.437533Z","caller":"traceutil/trace.go:171","msg":"trace[872468136] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:27; response_revision:8753; }","duration":"832.640003ms","start":"2026-06-15T12:05:10.604878Z","end":"2026-06-15T12:05:11.437518Z","steps":["trace[872468136] 'agreement among raft nodes before linearized reading' (duration: 832.161951ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T12:05:11.437584Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T12:05:10.60486Z","time spent":"832.711795ms","remote":"127.0.0.1:41438","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":27,"response size":234798,"request content":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" "} {"level":"info","ts":"2026-06-15T12:05:11.437784Z","caller":"traceutil/trace.go:171","msg":"trace[1116093333] transaction","detail":"{read_only:false; response_revision:8751; number_of_response:1; }","duration":"563.61074ms","start":"2026-06-15T12:05:10.874157Z","end":"2026-06-15T12:05:11.437767Z","steps":["trace[1116093333] 'process raft request' (duration: 562.231697ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T12:05:11.43784Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T12:05:10.874115Z","time spent":"563.698962ms","remote":"127.0.0.1:41326","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":684,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T12:05:11.437957Z","caller":"traceutil/trace.go:171","msg":"trace[1469715090] transaction","detail":"{read_only:false; response_revision:8752; number_of_response:1; }","duration":"464.51489ms","start":"2026-06-15T12:05:10.973431Z","end":"2026-06-15T12:05:11.437946Z","steps":["trace[1469715090] 'process raft request' (duration: 463.023484ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T12:05:11.438012Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T12:05:10.973409Z","time spent":"464.577821ms","remote":"127.0.0.1:41510","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T12:05:11.437006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"827.46712ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T12:05:11.438094Z","caller":"traceutil/trace.go:171","msg":"trace[1257706286] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8753; }","duration":"828.610697ms","start":"2026-06-15T12:05:10.609476Z","end":"2026-06-15T12:05:11.438087Z","steps":["trace[1257706286] 'agreement among raft nodes before linearized reading' (duration: 827.470059ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T12:05:11.438125Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T12:05:10.609465Z","time spent":"828.652618ms","remote":"127.0.0.1:41236","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-15T12:05:11.801769Z","caller":"traceutil/trace.go:171","msg":"trace[1020925498] transaction","detail":"{read_only:false; response_revision:8754; number_of_response:1; }","duration":"358.236757ms","start":"2026-06-15T12:05:11.443489Z","end":"2026-06-15T12:05:11.801726Z","steps":["trace[1020925498] 'process raft request' (duration: 318.016566ms)","trace[1020925498] 'compare' (duration: 39.854173ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T12:05:11.801957Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T12:05:11.443457Z","time spent":"358.406202ms","remote":"127.0.0.1:41510","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T12:05:13.883744Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002374.wal"} {"level":"info","ts":"2026-06-15T12:05:19.936486Z","caller":"traceutil/trace.go:171","msg":"trace[1352045373] linearizableReadLoop","detail":"{readStateIndex:9147; appliedIndex:9146; }","duration":"131.643348ms","start":"2026-06-15T12:05:19.804819Z","end":"2026-06-15T12:05:19.936462Z","steps":["trace[1352045373] 'read index received' (duration: 78.861206ms)","trace[1352045373] 'applied index is now lower than readState.Index' (duration: 52.781332ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T12:05:19.936592Z","caller":"traceutil/trace.go:171","msg":"trace[2086534882] transaction","detail":"{read_only:false; response_revision:8832; number_of_response:1; }","duration":"140.956671ms","start":"2026-06-15T12:05:19.795628Z","end":"2026-06-15T12:05:19.936585Z","steps":["trace[2086534882] 'process raft request' (duration: 88.029735ms)","trace[2086534882] 'compare' (duration: 52.644809ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T12:05:19.936799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.947326ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/rook-ceph-detect-version\" ","response":"range_response_count:1 size:3066"} {"level":"info","ts":"2026-06-15T12:05:19.936917Z","caller":"traceutil/trace.go:171","msg":"trace[1040933553] range","detail":"{range_begin:/registry/jobs/openstack/rook-ceph-detect-version; range_end:; response_count:1; response_revision:8832; }","duration":"132.106829ms","start":"2026-06-15T12:05:19.804778Z","end":"2026-06-15T12:05:19.936885Z","steps":["trace[1040933553] 'agreement among raft nodes before linearized reading' (duration: 131.818802ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T12:05:19.940092Z","caller":"traceutil/trace.go:171","msg":"trace[897335851] transaction","detail":"{read_only:false; response_revision:8833; number_of_response:1; }","duration":"131.472334ms","start":"2026-06-15T12:05:19.808586Z","end":"2026-06-15T12:05:19.940059Z","steps":["trace[897335851] 'process raft request' (duration: 131.31174ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T12:05:20.761148Z","caller":"traceutil/trace.go:171","msg":"trace[145487367] transaction","detail":"{read_only:false; response_revision:8839; number_of_response:1; }","duration":"133.247056ms","start":"2026-06-15T12:05:20.627875Z","end":"2026-06-15T12:05:20.761122Z","steps":["trace[145487367] 'process raft request' (duration: 133.074452ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T12:05:21.243874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.866843ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-15T12:05:21.243979Z","caller":"traceutil/trace.go:171","msg":"trace[640129406] linearizableReadLoop","detail":"{readStateIndex:9155; appliedIndex:9154; }","duration":"469.448538ms","start":"2026-06-15T12:05:20.774513Z","end":"2026-06-15T12:05:21.243961Z","steps":["trace[640129406] 'read index received' (duration: 253.40042ms)","trace[640129406] 'applied index is now lower than readState.Index' (duration: 216.046678ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T12:05:21.244215Z","caller":"traceutil/trace.go:171","msg":"trace[1464873583] transaction","detail":"{read_only:false; response_revision:8840; number_of_response:1; }","duration":"594.421616ms","start":"2026-06-15T12:05:20.649781Z","end":"2026-06-15T12:05:21.244202Z","steps":["trace[1464873583] 'process raft request' (duration: 378.144563ms)","trace[1464873583] 'compare' (duration: 213.968768ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T12:05:21.244289Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T12:05:20.649753Z","time spent":"594.498319ms","remote":"127.0.0.1:41510","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T12:05:21.244569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"470.037202ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-6xvbt\" ","response":"range_response_count:1 size:4653"} {"level":"info","ts":"2026-06-15T12:05:21.244604Z","caller":"traceutil/trace.go:171","msg":"trace[844739325] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-6xvbt; range_end:; response_count:1; response_revision:8840; }","duration":"470.143715ms","start":"2026-06-15T12:05:20.774451Z","end":"2026-06-15T12:05:21.244594Z","steps":["trace[844739325] 'agreement among raft nodes before linearized reading' (duration: 469.998871ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T12:05:21.244632Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T12:05:20.774427Z","time spent":"470.199486ms","remote":"127.0.0.1:41438","response type":"/etcdserverpb.KV/Range","request count":0,"request size":57,"response count":1,"response size":4676,"request content":"key:\"/registry/pods/openstack/rook-ceph-detect-version-6xvbt\" "} {"level":"warn","ts":"2026-06-15T12:05:21.264218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.691033ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/users/\" range_end:\"/registry/rabbitmq.com/users0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T12:05:21.264309Z","caller":"traceutil/trace.go:171","msg":"trace[851239402] range","detail":"{range_begin:/registry/rabbitmq.com/users/; range_end:/registry/rabbitmq.com/users0; response_count:0; response_revision:8842; }","duration":"354.852117ms","start":"2026-06-15T12:05:20.909438Z","end":"2026-06-15T12:05:21.26429Z","steps":["trace[851239402] 'agreement among raft nodes before linearized reading' (duration: 354.680883ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T12:05:21.264342Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T12:05:20.909413Z","time spent":"354.923429ms","remote":"127.0.0.1:44456","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":0,"response size":28,"request content":"key:\"/registry/rabbitmq.com/users/\" range_end:\"/registry/rabbitmq.com/users0\" count_only:true "} {"level":"info","ts":"2026-06-15T12:05:21.264589Z","caller":"traceutil/trace.go:171","msg":"trace[286397244] transaction","detail":"{read_only:false; response_revision:8841; number_of_response:1; }","duration":"489.756474ms","start":"2026-06-15T12:05:20.774797Z","end":"2026-06-15T12:05:21.264553Z","steps":["trace[286397244] 'process raft request' (duration: 489.054257ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T12:05:21.264663Z","caller":"traceutil/trace.go:171","msg":"trace[10623743] transaction","detail":"{read_only:false; response_revision:8842; number_of_response:1; }","duration":"462.571143ms","start":"2026-06-15T12:05:20.802084Z","end":"2026-06-15T12:05:21.264655Z","steps":["trace[10623743] 'process raft request' (duration: 461.973539ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T12:05:21.264733Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T12:05:20.802063Z","time spent":"462.618214ms","remote":"127.0.0.1:41492","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3037,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T12:05:21.26477Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T12:05:20.774765Z","time spent":"489.920907ms","remote":"127.0.0.1:41326","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":746,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-15T12:05:21.264928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.510536ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-06-15T12:05:21.264952Z","caller":"traceutil/trace.go:171","msg":"trace[837167038] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8842; }","duration":"305.608559ms","start":"2026-06-15T12:05:20.959339Z","end":"2026-06-15T12:05:21.264948Z","steps":["trace[837167038] 'agreement among raft nodes before linearized reading' (duration: 305.488747ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T12:05:21.264966Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T12:05:20.959298Z","time spent":"305.665231ms","remote":"127.0.0.1:41510","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-15T12:05:21.630345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.357848ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-15T12:05:21.630627Z","caller":"traceutil/trace.go:171","msg":"trace[344829464] transaction","detail":"{read_only:false; response_revision:8848; number_of_response:1; }","duration":"122.791776ms","start":"2026-06-15T12:05:21.507817Z","end":"2026-06-15T12:05:21.630609Z","steps":["trace[344829464] 'process raft request' (duration: 122.741045ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T12:05:21.630682Z","caller":"traceutil/trace.go:171","msg":"trace[1424221988] transaction","detail":"{read_only:false; response_revision:8845; number_of_response:1; }","duration":"232.152922ms","start":"2026-06-15T12:05:21.398357Z","end":"2026-06-15T12:05:21.63051Z","steps":["trace[1424221988] 'process raft request' (duration: 111.520107ms)","trace[1424221988] 'compare' (duration: 120.222935ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T12:05:21.630876Z","caller":"traceutil/trace.go:171","msg":"trace[1463547540] linearizableReadLoop","detail":"{readStateIndex:9160; appliedIndex:9159; }","duration":"178.755454ms","start":"2026-06-15T12:05:21.452107Z","end":"2026-06-15T12:05:21.630863Z","steps":["trace[1463547540] 'read index received' (duration: 57.786412ms)","trace[1463547540] 'applied index is now lower than readState.Index' (duration: 120.967492ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T12:05:21.63106Z","caller":"traceutil/trace.go:171","msg":"trace[1304759559] transaction","detail":"{read_only:false; response_revision:8846; number_of_response:1; }","duration":"144.976886ms","start":"2026-06-15T12:05:21.486015Z","end":"2026-06-15T12:05:21.630992Z","steps":["trace[1304759559] 'process raft request' (duration: 144.448753ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T12:05:21.631003Z","caller":"traceutil/trace.go:171","msg":"trace[6193567] transaction","detail":"{read_only:false; response_revision:8847; number_of_response:1; }","duration":"126.912684ms","start":"2026-06-15T12:05:21.50407Z","end":"2026-06-15T12:05:21.630983Z","steps":["trace[6193567] 'process raft request' (duration: 126.451573ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T12:05:21.631311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.048491ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-15T12:05:21.63139Z","caller":"traceutil/trace.go:171","msg":"trace[368172170] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8848; }","duration":"179.327547ms","start":"2026-06-15T12:05:21.452051Z","end":"2026-06-15T12:05:21.631378Z","steps":["trace[368172170] 'agreement among raft nodes before linearized reading' (duration: 179.00872ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T12:05:21.631483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.375436ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-k46bw\" ","response":"range_response_count:1 size:6451"} {"level":"info","ts":"2026-06-15T12:05:21.631792Z","caller":"traceutil/trace.go:171","msg":"trace[356152681] range","detail":"{range_begin:/registry/pods/openstack/keepalived-k46bw; range_end:; response_count:1; response_revision:8848; }","duration":"109.727245ms","start":"2026-06-15T12:05:21.522039Z","end":"2026-06-15T12:05:21.631766Z","steps":["trace[356152681] 'agreement among raft nodes before linearized reading' (duration: 109.071929ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T12:05:21.970914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.495294ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-15T12:05:21.971358Z","caller":"traceutil/trace.go:171","msg":"trace[230627568] transaction","detail":"{read_only:false; response_revision:8849; number_of_response:1; }","duration":"336.234202ms","start":"2026-06-15T12:05:21.635082Z","end":"2026-06-15T12:05:21.971316Z","steps":["trace[230627568] 'process raft request' (duration: 176.239865ms)","trace[230627568] 'compare' (duration: 159.018763ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T12:05:21.971517Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T12:05:21.635066Z","time spent":"336.370434ms","remote":"127.0.0.1:41510","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T12:05:21.971664Z","caller":"traceutil/trace.go:171","msg":"trace[1278895166] linearizableReadLoop","detail":"{readStateIndex:9164; appliedIndex:9163; }","duration":"334.508691ms","start":"2026-06-15T12:05:21.637103Z","end":"2026-06-15T12:05:21.971612Z","steps":["trace[1278895166] 'read index received' (duration: 174.33088ms)","trace[1278895166] 'applied index is now lower than readState.Index' (duration: 160.16561ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T12:05:21.972259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.151436ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:27 size:234690"} {"level":"info","ts":"2026-06-15T12:05:21.972482Z","caller":"traceutil/trace.go:171","msg":"trace[1022918565] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:27; response_revision:8849; }","duration":"335.391372ms","start":"2026-06-15T12:05:21.63707Z","end":"2026-06-15T12:05:21.972461Z","steps":["trace[1022918565] 'agreement among raft nodes before linearized reading' (duration: 334.635084ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T12:05:21.972581Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T12:05:21.637053Z","time spent":"335.511475ms","remote":"127.0.0.1:41438","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":27,"response size":234713,"request content":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" "} {"level":"info","ts":"2026-06-15T12:05:21.974515Z","caller":"traceutil/trace.go:171","msg":"trace[775762708] transaction","detail":"{read_only:false; response_revision:8850; number_of_response:1; }","duration":"263.81999ms","start":"2026-06-15T12:05:21.710685Z","end":"2026-06-15T12:05:21.974505Z","steps":["trace[775762708] 'process raft request' (duration: 260.48084ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T12:05:22.186048Z","caller":"traceutil/trace.go:171","msg":"trace[1103034007] transaction","detail":"{read_only:false; response_revision:8853; number_of_response:1; }","duration":"204.047001ms","start":"2026-06-15T12:05:21.981973Z","end":"2026-06-15T12:05:22.18602Z","steps":["trace[1103034007] 'process raft request' (duration: 203.980229ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T12:05:22.186134Z","caller":"traceutil/trace.go:171","msg":"trace[1001714454] transaction","detail":"{read_only:false; response_revision:8851; number_of_response:1; }","duration":"207.261677ms","start":"2026-06-15T12:05:21.978843Z","end":"2026-06-15T12:05:22.186104Z","steps":["trace[1001714454] 'process raft request' (duration: 112.578692ms)","trace[1001714454] 'compare' (duration: 94.288965ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T12:05:22.186506Z","caller":"traceutil/trace.go:171","msg":"trace[2055020529] transaction","detail":"{read_only:false; response_revision:8852; number_of_response:1; }","duration":"205.606428ms","start":"2026-06-15T12:05:21.98054Z","end":"2026-06-15T12:05:22.186146Z","steps":["trace[2055020529] 'process raft request' (duration: 205.351152ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T12:05:22.188382Z","caller":"traceutil/trace.go:171","msg":"trace[1389911816] linearizableReadLoop","detail":"{readStateIndex:9166; appliedIndex:9165; }","duration":"209.108481ms","start":"2026-06-15T12:05:21.979244Z","end":"2026-06-15T12:05:22.188352Z","steps":["trace[1389911816] 'read index received' (duration: 112.141172ms)","trace[1389911816] 'applied index is now lower than readState.Index' (duration: 96.963359ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T12:05:22.188756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.5001ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rook-ceph-pdbstatemap\" ","response":"range_response_count:1 size:356"} {"level":"info","ts":"2026-06-15T12:05:22.188827Z","caller":"traceutil/trace.go:171","msg":"trace[132446550] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-pdbstatemap; range_end:; response_count:1; response_revision:8853; }","duration":"209.656974ms","start":"2026-06-15T12:05:21.979153Z","end":"2026-06-15T12:05:22.18881Z","steps":["trace[132446550] 'agreement among raft nodes before linearized reading' (duration: 209.298086ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T12:05:22.72626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.612028ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-15T12:05:22.726545Z","caller":"traceutil/trace.go:171","msg":"trace[478065628] transaction","detail":"{read_only:false; response_revision:8856; number_of_response:1; }","duration":"287.64409ms","start":"2026-06-15T12:05:22.438866Z","end":"2026-06-15T12:05:22.72651Z","steps":["trace[478065628] 'process raft request' (duration: 91.657162ms)","trace[478065628] 'compare' (duration: 195.068116ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T12:05:22.821426Z","caller":"traceutil/trace.go:171","msg":"trace[745579103] linearizableReadLoop","detail":"{readStateIndex:9173; appliedIndex:9170; }","duration":"211.916609ms","start":"2026-06-15T12:05:22.609482Z","end":"2026-06-15T12:05:22.821399Z","steps":["trace[745579103] 'read index received' (duration: 49.859573ms)","trace[745579103] 'applied index is now lower than readState.Index' (duration: 162.055526ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T12:05:22.821538Z","caller":"traceutil/trace.go:171","msg":"trace[87762989] transaction","detail":"{read_only:false; response_revision:8857; number_of_response:1; }","duration":"339.675484ms","start":"2026-06-15T12:05:22.481808Z","end":"2026-06-15T12:05:22.821484Z","steps":["trace[87762989] 'process raft request' (duration: 339.438118ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T12:05:22.821596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.089843ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T12:05:22.821696Z","caller":"traceutil/trace.go:171","msg":"trace[43745993] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8857; }","duration":"212.249156ms","start":"2026-06-15T12:05:22.609426Z","end":"2026-06-15T12:05:22.821675Z","steps":["trace[43745993] 'agreement among raft nodes before linearized reading' (duration: 212.074232ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T12:05:22.821773Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T12:05:22.481786Z","time spent":"339.859719ms","remote":"127.0.0.1:41510","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T12:05:22.821842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.740176ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephblockpools/\" range_end:\"/registry/ceph.rook.io/cephblockpools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T12:05:22.82189Z","caller":"traceutil/trace.go:171","msg":"trace[896811878] range","detail":"{range_begin:/registry/ceph.rook.io/cephblockpools/; range_end:/registry/ceph.rook.io/cephblockpools0; response_count:0; response_revision:8857; }","duration":"123.067813ms","start":"2026-06-15T12:05:22.69881Z","end":"2026-06-15T12:05:22.821877Z","steps":["trace[896811878] 'agreement among raft nodes before linearized reading' (duration: 122.755506ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T12:05:22.930049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.717234ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:3958"} {"level":"info","ts":"2026-06-15T12:05:22.930159Z","caller":"traceutil/trace.go:171","msg":"trace[1006977204] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:8857; }","duration":"104.868089ms","start":"2026-06-15T12:05:22.825267Z","end":"2026-06-15T12:05:22.930135Z","steps":["trace[1006977204] 'range keys from in-memory index tree' (duration: 104.516039ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T12:05:23.504072Z","caller":"traceutil/trace.go:171","msg":"trace[1157584131] transaction","detail":"{read_only:false; response_revision:8858; number_of_response:1; }","duration":"297.791253ms","start":"2026-06-15T12:05:23.206249Z","end":"2026-06-15T12:05:23.50404Z","steps":["trace[1157584131] 'process raft request' (duration: 297.577548ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T12:05:23.600031Z","caller":"traceutil/trace.go:171","msg":"trace[1275837259] linearizableReadLoop","detail":"{readStateIndex:9175; appliedIndex:9173; }","duration":"294.661377ms","start":"2026-06-15T12:05:23.305321Z","end":"2026-06-15T12:05:23.599982Z","steps":["trace[1275837259] 'read index received' (duration: 198.553579ms)","trace[1275837259] 'applied index is now lower than readState.Index' (duration: 96.106188ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T12:05:23.600229Z","caller":"traceutil/trace.go:171","msg":"trace[747529272] transaction","detail":"{read_only:false; response_revision:8859; number_of_response:1; }","duration":"349.51799ms","start":"2026-06-15T12:05:23.250564Z","end":"2026-06-15T12:05:23.600082Z","steps":["trace[747529272] 'process raft request' (duration: 299.196706ms)","trace[747529272] 'compare' (duration: 49.957055ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T12:05:23.600325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.980555ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"warn","ts":"2026-06-15T12:05:23.600357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.992098ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-15T12:05:23.600418Z","caller":"traceutil/trace.go:171","msg":"trace[1086072916] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8859; }","duration":"295.130459ms","start":"2026-06-15T12:05:23.305264Z","end":"2026-06-15T12:05:23.600395Z","steps":["trace[1086072916] 'agreement among raft nodes before linearized reading' (duration: 294.878113ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T12:05:23.600442Z","caller":"traceutil/trace.go:171","msg":"trace[440341005] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8859; }","duration":"158.141933ms","start":"2026-06-15T12:05:23.442278Z","end":"2026-06-15T12:05:23.60042Z","steps":["trace[440341005] 'agreement among raft nodes before linearized reading' (duration: 157.914837ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T12:05:23.600523Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T12:05:23.250546Z","time spent":"349.798946ms","remote":"127.0.0.1:41510","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":554,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T12:05:23.944231Z","caller":"traceutil/trace.go:171","msg":"trace[119887440] transaction","detail":"{read_only:false; response_revision:8861; number_of_response:1; }","duration":"338.427594ms","start":"2026-06-15T12:05:23.605775Z","end":"2026-06-15T12:05:23.944203Z","steps":["trace[119887440] 'process raft request' (duration: 338.134687ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T12:05:23.944436Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T12:05:23.605747Z","time spent":"338.579148ms","remote":"127.0.0.1:41510","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T12:05:23.944601Z","caller":"traceutil/trace.go:171","msg":"trace[1932398846] transaction","detail":"{read_only:false; response_revision:8863; number_of_response:1; }","duration":"307.273998ms","start":"2026-06-15T12:05:23.637284Z","end":"2026-06-15T12:05:23.944558Z","steps":["trace[1932398846] 'process raft request' (duration: 307.123585ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T12:05:23.944667Z","caller":"traceutil/trace.go:171","msg":"trace[527547311] linearizableReadLoop","detail":"{readStateIndex:9177; appliedIndex:9175; }","duration":"309.330578ms","start":"2026-06-15T12:05:23.635304Z","end":"2026-06-15T12:05:23.944634Z","steps":["trace[527547311] 'read index received' (duration: 11.861044ms)","trace[527547311] 'applied index is now lower than readState.Index' (duration: 297.468024ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T12:05:23.944733Z","caller":"traceutil/trace.go:171","msg":"trace[1484487829] transaction","detail":"{read_only:false; response_revision:8864; number_of_response:1; }","duration":"307.198077ms","start":"2026-06-15T12:05:23.637522Z","end":"2026-06-15T12:05:23.944721Z","steps":["trace[1484487829] 'process raft request' (duration: 306.994152ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T12:05:23.944789Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T12:05:23.637272Z","time spent":"307.425033ms","remote":"127.0.0.1:41510","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T12:05:23.944927Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.618125ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"warn","ts":"2026-06-15T12:05:23.944933Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T12:05:23.637472Z","time spent":"307.32713ms","remote":"127.0.0.1:41510","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T12:05:23.944594Z","caller":"traceutil/trace.go:171","msg":"trace[1655862599] transaction","detail":"{read_only:false; response_revision:8862; number_of_response:1; }","duration":"307.703879ms","start":"2026-06-15T12:05:23.636832Z","end":"2026-06-15T12:05:23.944536Z","steps":["trace[1655862599] 'process raft request' (duration: 307.32223ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T12:05:23.945001Z","caller":"traceutil/trace.go:171","msg":"trace[831561488] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8864; }","duration":"309.713468ms","start":"2026-06-15T12:05:23.635268Z","end":"2026-06-15T12:05:23.944982Z","steps":["trace[831561488] 'agreement among raft nodes before linearized reading' (duration: 309.514203ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T12:05:23.945169Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T12:05:23.635257Z","time spent":"309.892122ms","remote":"127.0.0.1:41510","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-15T12:05:23.945045Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T12:05:23.636805Z","time spent":"308.192711ms","remote":"127.0.0.1:41510","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-06-15T12:05:24.090658Z","caller":"traceutil/trace.go:171","msg":"trace[267465581] linearizableReadLoop","detail":"{readStateIndex:9181; appliedIndex:9180; }","duration":"114.188291ms","start":"2026-06-15T12:05:23.976441Z","end":"2026-06-15T12:05:24.090629Z","steps":["trace[267465581] 'read index received' (duration: 32.967029ms)","trace[267465581] 'applied index is now lower than readState.Index' (duration: 81.219812ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T12:05:24.090837Z","caller":"traceutil/trace.go:171","msg":"trace[1953345236] transaction","detail":"{read_only:false; response_revision:8865; number_of_response:1; }","duration":"141.144246ms","start":"2026-06-15T12:05:23.94968Z","end":"2026-06-15T12:05:24.090824Z","steps":["trace[1953345236] 'process raft request' (duration: 59.853512ms)","trace[1953345236] 'compare' (duration: 80.851933ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T12:05:24.09117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.713954ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-06-15T12:05:24.091224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.651317ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-k46bw\" ","response":"range_response_count:1 size:6451"} {"level":"info","ts":"2026-06-15T12:05:24.09128Z","caller":"traceutil/trace.go:171","msg":"trace[1397648871] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8865; }","duration":"114.888548ms","start":"2026-06-15T12:05:23.976363Z","end":"2026-06-15T12:05:24.091251Z","steps":["trace[1397648871] 'agreement among raft nodes before linearized reading' (duration: 114.500639ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T12:05:24.09135Z","caller":"traceutil/trace.go:171","msg":"trace[1430549620] range","detail":"{range_begin:/registry/pods/openstack/keepalived-k46bw; range_end:; response_count:1; response_revision:8865; }","duration":"110.81273ms","start":"2026-06-15T12:05:23.980502Z","end":"2026-06-15T12:05:24.091314Z","steps":["trace[1430549620] 'agreement among raft nodes before linearized reading' (duration: 110.407821ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T12:05:31.887752Z","caller":"traceutil/trace.go:171","msg":"trace[1881015404] transaction","detail":"{read_only:false; response_revision:8931; number_of_response:1; }","duration":"174.307449ms","start":"2026-06-15T12:05:31.713411Z","end":"2026-06-15T12:05:31.887718Z","steps":["trace[1881015404] 'process raft request' (duration: 129.413186ms)","trace[1881015404] 'compare' (duration: 44.648038ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T12:06:28.646022Z","caller":"traceutil/trace.go:171","msg":"trace[1777276600] transaction","detail":"{read_only:false; response_revision:9543; number_of_response:1; }","duration":"143.93986ms","start":"2026-06-15T12:06:28.502046Z","end":"2026-06-15T12:06:28.645985Z","steps":["trace[1777276600] 'process raft request' (duration: 143.630042ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T12:06:50.271755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.833019ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-15T12:06:50.271909Z","caller":"traceutil/trace.go:171","msg":"trace[1470297880] transaction","detail":"{read_only:false; response_revision:9661; number_of_response:1; }","duration":"181.249064ms","start":"2026-06-15T12:06:50.090634Z","end":"2026-06-15T12:06:50.271883Z","steps":["trace[1470297880] 'process raft request' (duration: 77.163869ms)","trace[1470297880] 'compare' (duration: 103.642654ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T12:06:50.79354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"358.394649ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-15T12:06:50.79364Z","caller":"traceutil/trace.go:171","msg":"trace[649391595] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:9661; }","duration":"358.563733ms","start":"2026-06-15T12:06:50.435053Z","end":"2026-06-15T12:06:50.793617Z","steps":["trace[649391595] 'range keys from in-memory index tree' (duration: 358.176153ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T12:06:50.793678Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T12:06:50.434988Z","time spent":"358.682796ms","remote":"127.0.0.1:41510","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-15T12:06:50.879658Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"8a0c9a032e61a05a","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-15T12:06:50.879846Z","caller":"traceutil/trace.go:171","msg":"trace[1936129405] transaction","detail":"{read_only:false; response_revision:9662; number_of_response:1; }","duration":"436.123942ms","start":"2026-06-15T12:06:50.443686Z","end":"2026-06-15T12:06:50.87981Z","steps":["trace[1936129405] 'process raft request' (duration: 435.715402ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T12:06:50.880064Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T12:06:50.44366Z","time spent":"436.248715ms","remote":"127.0.0.1:41510","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T12:06:51.092551Z","caller":"traceutil/trace.go:171","msg":"trace[1697584550] transaction","detail":"{read_only:false; response_revision:9663; number_of_response:1; }","duration":"590.682964ms","start":"2026-06-15T12:06:50.501838Z","end":"2026-06-15T12:06:51.092521Z","steps":["trace[1697584550] 'process raft request' (duration: 589.528926ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T12:06:51.092733Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T12:06:50.501804Z","time spent":"590.836088ms","remote":"127.0.0.1:41510","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-06-15T12:06:51.223915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.282357ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-15T12:06:51.224276Z","caller":"traceutil/trace.go:171","msg":"trace[1080435038] transaction","detail":"{read_only:false; response_revision:9664; number_of_response:1; }","duration":"693.681533ms","start":"2026-06-15T12:06:50.530525Z","end":"2026-06-15T12:06:51.224206Z","steps":["trace[1080435038] 'process raft request' (duration: 561.977307ms)","trace[1080435038] 'compare' (duration: 131.04195ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T12:06:51.224393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T12:06:50.530494Z","time spent":"693.844147ms","remote":"127.0.0.1:41510","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T12:06:51.22492Z","caller":"traceutil/trace.go:171","msg":"trace[1542180259] linearizableReadLoop","detail":"{readStateIndex:10003; appliedIndex:10000; }","duration":"614.525046ms","start":"2026-06-15T12:06:50.610383Z","end":"2026-06-15T12:06:51.224908Z","steps":["trace[1542180259] 'read index received' (duration: 268.928845ms)","trace[1542180259] 'applied index is now lower than readState.Index' (duration: 345.595101ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T12:06:51.225057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"614.68682ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T12:06:51.225092Z","caller":"traceutil/trace.go:171","msg":"trace[644643645] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:9665; }","duration":"614.779472ms","start":"2026-06-15T12:06:50.610304Z","end":"2026-06-15T12:06:51.225083Z","steps":["trace[644643645] 'agreement among raft nodes before linearized reading' (duration: 614.69931ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T12:06:51.225125Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T12:06:50.610272Z","time spent":"614.846674ms","remote":"127.0.0.1:41236","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-15T12:06:51.225246Z","caller":"traceutil/trace.go:171","msg":"trace[747137029] transaction","detail":"{read_only:false; response_revision:9665; number_of_response:1; }","duration":"426.88501ms","start":"2026-06-15T12:06:50.798229Z","end":"2026-06-15T12:06:51.225114Z","steps":["trace[747137029] 'process raft request' (duration: 425.911606ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T12:06:51.225314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"420.846554ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"warn","ts":"2026-06-15T12:06:51.225386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.636373ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-k46bw\" ","response":"range_response_count:1 size:6451"} {"level":"info","ts":"2026-06-15T12:06:51.225501Z","caller":"traceutil/trace.go:171","msg":"trace[1714383809] range","detail":"{range_begin:/registry/pods/openstack/keepalived-k46bw; range_end:; response_count:1; response_revision:9665; }","duration":"378.788346ms","start":"2026-06-15T12:06:50.846679Z","end":"2026-06-15T12:06:51.225468Z","steps":["trace[1714383809] 'agreement among raft nodes before linearized reading' (duration: 378.461418ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T12:06:51.225531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"413.56887ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/prometheusrules/\" range_end:\"/registry/monitoring.coreos.com/prometheusrules0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-15T12:06:51.22553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"391.692105ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-06-15T12:06:51.225563Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T12:06:50.846665Z","time spent":"378.886719ms","remote":"127.0.0.1:41438","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6474,"request content":"key:\"/registry/pods/openstack/keepalived-k46bw\" "} {"level":"info","ts":"2026-06-15T12:06:51.22558Z","caller":"traceutil/trace.go:171","msg":"trace[321455560] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:9665; }","duration":"391.764617ms","start":"2026-06-15T12:06:50.833804Z","end":"2026-06-15T12:06:51.225569Z","steps":["trace[321455560] 'agreement among raft nodes before linearized reading' (duration: 391.607464ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T12:06:51.225595Z","caller":"traceutil/trace.go:171","msg":"trace[225495023] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheusrules/; range_end:/registry/monitoring.coreos.com/prometheusrules0; response_count:0; response_revision:9665; }","duration":"413.660842ms","start":"2026-06-15T12:06:50.811903Z","end":"2026-06-15T12:06:51.225564Z","steps":["trace[225495023] 'agreement among raft nodes before linearized reading' (duration: 413.54807ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T12:06:51.225646Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T12:06:50.811893Z","time spent":"413.741854ms","remote":"127.0.0.1:53344","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":31,"response size":30,"request content":"key:\"/registry/monitoring.coreos.com/prometheusrules/\" range_end:\"/registry/monitoring.coreos.com/prometheusrules0\" count_only:true "} {"level":"warn","ts":"2026-06-15T12:06:51.225694Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"404.721097ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"warn","ts":"2026-06-15T12:06:51.225818Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T12:06:50.798197Z","time spent":"427.174866ms","remote":"127.0.0.1:41510","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T12:06:51.22589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.555678ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-06-15T12:06:51.225935Z","caller":"traceutil/trace.go:171","msg":"trace[2124729273] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:9665; }","duration":"337.63991ms","start":"2026-06-15T12:06:50.888284Z","end":"2026-06-15T12:06:51.225924Z","steps":["trace[2124729273] 'agreement among raft nodes before linearized reading' (duration: 337.527017ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T12:06:51.225937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.829394ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-15T12:06:51.225976Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T12:06:50.888258Z","time spent":"337.705002ms","remote":"127.0.0.1:41510","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-15T12:06:51.226012Z","caller":"traceutil/trace.go:171","msg":"trace[1306629383] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:9665; }","duration":"261.937696ms","start":"2026-06-15T12:06:50.964057Z","end":"2026-06-15T12:06:51.225994Z","steps":["trace[1306629383] 'agreement among raft nodes before linearized reading' (duration: 261.782602ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T12:06:51.225416Z","caller":"traceutil/trace.go:171","msg":"trace[1009233610] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:9665; }","duration":"421.003708ms","start":"2026-06-15T12:06:50.804383Z","end":"2026-06-15T12:06:51.225386Z","steps":["trace[1009233610] 'agreement among raft nodes before linearized reading' (duration: 420.719341ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T12:06:51.225964Z","caller":"traceutil/trace.go:171","msg":"trace[1747210775] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:9665; }","duration":"404.985804ms","start":"2026-06-15T12:06:50.820875Z","end":"2026-06-15T12:06:51.22586Z","steps":["trace[1747210775] 'agreement among raft nodes before linearized reading' (duration: 404.440761ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T12:06:51.226066Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T12:06:50.804366Z","time spent":"421.688585ms","remote":"127.0.0.1:41510","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-15T12:06:51.226138Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T12:06:50.82085Z","time spent":"405.23234ms","remote":"127.0.0.1:41510","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-15T12:06:51.22654Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T12:06:50.833793Z","time spent":"392.581607ms","remote":"127.0.0.1:41510","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":"info","ts":"2026-06-15T12:06:51.411053Z","caller":"traceutil/trace.go:171","msg":"trace[1729497863] transaction","detail":"{read_only:false; response_revision:9666; number_of_response:1; }","duration":"180.540196ms","start":"2026-06-15T12:06:51.23046Z","end":"2026-06-15T12:06:51.411Z","steps":["trace[1729497863] 'process raft request' (duration: 101.203135ms)","trace[1729497863] 'compare' (duration: 79.177688ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T12:06:51.41868Z","caller":"traceutil/trace.go:171","msg":"trace[119928937] transaction","detail":"{read_only:false; response_revision:9668; number_of_response:1; }","duration":"187.656258ms","start":"2026-06-15T12:06:51.230993Z","end":"2026-06-15T12:06:51.418649Z","steps":["trace[119928937] 'process raft request' (duration: 187.566316ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T12:06:51.41872Z","caller":"traceutil/trace.go:171","msg":"trace[1884945146] transaction","detail":"{read_only:false; response_revision:9667; number_of_response:1; }","duration":"188.015825ms","start":"2026-06-15T12:06:51.230663Z","end":"2026-06-15T12:06:51.418678Z","steps":["trace[1884945146] 'process raft request' (duration: 187.649917ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T12:06:51.419657Z","caller":"traceutil/trace.go:171","msg":"trace[1683431820] transaction","detail":"{read_only:false; response_revision:9669; number_of_response:1; }","duration":"188.500878ms","start":"2026-06-15T12:06:51.231147Z","end":"2026-06-15T12:06:51.419648Z","steps":["trace[1683431820] 'process raft request' (duration: 187.457653ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T12:06:51.419592Z","caller":"traceutil/trace.go:171","msg":"trace[1305595419] linearizableReadLoop","detail":"{readStateIndex:10006; appliedIndex:10004; }","duration":"188.729813ms","start":"2026-06-15T12:06:51.230844Z","end":"2026-06-15T12:06:51.419574Z","steps":["trace[1305595419] 'read index received' (duration: 100.797336ms)","trace[1305595419] 'applied index is now lower than readState.Index' (duration: 87.931117ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T12:06:51.420578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.678415ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:32 size:297112"} {"level":"info","ts":"2026-06-15T12:06:51.420674Z","caller":"traceutil/trace.go:171","msg":"trace[1963850993] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:32; response_revision:9669; }","duration":"189.85283ms","start":"2026-06-15T12:06:51.230804Z","end":"2026-06-15T12:06:51.420657Z","steps":["trace[1963850993] 'agreement among raft nodes before linearized reading' (duration: 188.987369ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T12:06:51.432797Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-06-15T12:06:51.432917Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"warn","ts":"2026-06-15T12:07:42.86828Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.281871ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-06-15T12:07:43.278358Z","caller":"traceutil/trace.go:171","msg":"trace[1804606814] transaction","detail":"{read_only:false; response_revision:10022; number_of_response:1; }","duration":"111.325112ms","start":"2026-06-15T12:07:43.166995Z","end":"2026-06-15T12:07:43.27832Z","steps":["trace[1804606814] 'process raft request' (duration: 111.049965ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T12:09:04.218147Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8213} {"level":"info","ts":"2026-06-15T12:09:04.316399Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8213,"took":"95.501678ms","hash":108676648,"current-db-size-bytes":57802752,"current-db-size":"58 MB","current-db-size-in-use-bytes":24813568,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-06-15T12:09:04.316495Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":108676648,"revision":8213,"compact-revision":6098}