{"level":"warn","ts":"2026-09-01T07:17:39.154624Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-01T07:17:39.154724Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.129:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://162.253.55.129:2380","--initial-cluster=instance=https://162.253.55.129:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.129:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.129:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-09-01T07:17:39.154798Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-01T07:17:39.154811Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.129:2380"]} {"level":"info","ts":"2026-09-01T07:17:39.154837Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-09-01T07:17:39.1556Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.129:2379"]} {"level":"info","ts":"2026-09-01T07:17:39.155688Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.129:2380"],"listen-peer-urls":["https://162.253.55.129:2380"],"advertise-client-urls":["https://162.253.55.129:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.129:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.129:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-09-01T07:17:39.16123Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.263035ms"} {"level":"info","ts":"2026-09-01T07:17:39.1706Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"d232699cb6c87299","cluster-id":"f2b9115890c3fc7f"} {"level":"info","ts":"2026-09-01T07:17:39.170694Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d232699cb6c87299 switched to configuration voters=()"} {"level":"info","ts":"2026-09-01T07:17:39.170719Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d232699cb6c87299 became follower at term 0"} {"level":"info","ts":"2026-09-01T07:17:39.170737Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft d232699cb6c87299 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-01T07:17:39.170749Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d232699cb6c87299 became follower at term 1"} {"level":"info","ts":"2026-09-01T07:17:39.170803Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d232699cb6c87299 switched to configuration voters=(15146284618602803865)"} {"level":"warn","ts":"2026-09-01T07:17:39.178428Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-01T07:17:39.180616Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-01T07:17:39.18236Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-09-01T07:17:39.185274Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"d232699cb6c87299","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-01T07:17:39.18544Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"d232699cb6c87299","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-01T07:17:39.185592Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-09-01T07:17:39.185761Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-09-01T07:17:39.185779Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-09-01T07:17:39.187242Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d232699cb6c87299 switched to configuration voters=(15146284618602803865)"} {"level":"info","ts":"2026-09-01T07:17:39.187438Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"f2b9115890c3fc7f","local-member-id":"d232699cb6c87299","added-peer-id":"d232699cb6c87299","added-peer-peer-urls":["https://162.253.55.129:2380"]} {"level":"info","ts":"2026-09-01T07:17:39.192577Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-09-01T07:17:39.192722Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.129:2380"} {"level":"info","ts":"2026-09-01T07:17:39.192748Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.129:2380"} {"level":"info","ts":"2026-09-01T07:17:39.193183Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"d232699cb6c87299","initial-advertise-peer-urls":["https://162.253.55.129:2380"],"listen-peer-urls":["https://162.253.55.129:2380"],"advertise-client-urls":["https://162.253.55.129:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.129:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-01T07:17:39.193242Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-01T07:17:40.071343Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d232699cb6c87299 is starting a new election at term 1"} {"level":"info","ts":"2026-09-01T07:17:40.071404Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d232699cb6c87299 became pre-candidate at term 1"} {"level":"info","ts":"2026-09-01T07:17:40.071444Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d232699cb6c87299 received MsgPreVoteResp from d232699cb6c87299 at term 1"} {"level":"info","ts":"2026-09-01T07:17:40.071468Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d232699cb6c87299 became candidate at term 2"} {"level":"info","ts":"2026-09-01T07:17:40.071484Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d232699cb6c87299 received MsgVoteResp from d232699cb6c87299 at term 2"} {"level":"info","ts":"2026-09-01T07:17:40.071505Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d232699cb6c87299 became leader at term 2"} {"level":"info","ts":"2026-09-01T07:17:40.071519Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: d232699cb6c87299 elected leader d232699cb6c87299 at term 2"} {"level":"info","ts":"2026-09-01T07:17:40.072681Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-01T07:17:40.073975Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"d232699cb6c87299","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.129:2379]}","request-path":"/0/members/d232699cb6c87299/attributes","cluster-id":"f2b9115890c3fc7f","publish-timeout":"7s"} {"level":"info","ts":"2026-09-01T07:17:40.074019Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-01T07:17:40.074054Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-01T07:17:40.074257Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-01T07:17:40.074328Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-01T07:17:40.075048Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"f2b9115890c3fc7f","local-member-id":"d232699cb6c87299","cluster-version":"3.5"} {"level":"info","ts":"2026-09-01T07:17:40.075203Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-01T07:17:40.075252Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-01T07:17:40.077157Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.129:2379"} {"level":"info","ts":"2026-09-01T07:17:40.078234Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-01T07:18:33.165264Z","caller":"traceutil/trace.go:171","msg":"trace[1858424780] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"122.63107ms","start":"2026-09-01T07:18:33.042595Z","end":"2026-09-01T07:18:33.165226Z","steps":["trace[1858424780] 'process raft request' (duration: 122.107029ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T07:18:33.166932Z","caller":"traceutil/trace.go:171","msg":"trace[820540006] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"121.913913ms","start":"2026-09-01T07:18:33.044992Z","end":"2026-09-01T07:18:33.166906Z","steps":["trace[820540006] 'process raft request' (duration: 121.689659ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T07:18:39.142944Z","caller":"traceutil/trace.go:171","msg":"trace[1248726762] transaction","detail":"{read_only:false; response_revision:679; number_of_response:1; }","duration":"145.348958ms","start":"2026-09-01T07:18:38.997346Z","end":"2026-09-01T07:18:39.142695Z","steps":["trace[1248726762] 'process raft request' (duration: 144.400058ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T07:18:39.368481Z","caller":"traceutil/trace.go:171","msg":"trace[8292940] transaction","detail":"{read_only:false; response_revision:680; number_of_response:1; }","duration":"146.81847ms","start":"2026-09-01T07:18:39.221633Z","end":"2026-09-01T07:18:39.368452Z","steps":["trace[8292940] 'process raft request' (duration: 146.543594ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T07:18:39.693163Z","caller":"traceutil/trace.go:171","msg":"trace[303972130] linearizableReadLoop","detail":"{readStateIndex:706; appliedIndex:705; }","duration":"230.471591ms","start":"2026-09-01T07:18:39.462663Z","end":"2026-09-01T07:18:39.693135Z","steps":["trace[303972130] 'read index received' (duration: 230.314087ms)","trace[303972130] 'applied index is now lower than readState.Index' (duration: 156.374µs)"],"step_count":2} {"level":"info","ts":"2026-09-01T07:18:39.693284Z","caller":"traceutil/trace.go:171","msg":"trace[244642892] transaction","detail":"{read_only:false; response_revision:681; number_of_response:1; }","duration":"263.086843ms","start":"2026-09-01T07:18:39.430108Z","end":"2026-09-01T07:18:39.693195Z","steps":["trace[244642892] 'process raft request' (duration: 262.820597ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T07:18:39.693833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.129294ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-mnxfp\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-09-01T07:18:39.693996Z","caller":"traceutil/trace.go:171","msg":"trace[385478016] range","detail":"{range_begin:/registry/pods/kube-system/cilium-mnxfp; range_end:; response_count:1; response_revision:681; }","duration":"231.348149ms","start":"2026-09-01T07:18:39.462606Z","end":"2026-09-01T07:18:39.693954Z","steps":["trace[385478016] 'agreement among raft nodes before linearized reading' (duration: 230.722286ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T07:18:39.869753Z","caller":"traceutil/trace.go:171","msg":"trace[1582851390] transaction","detail":"{read_only:false; response_revision:682; number_of_response:1; }","duration":"171.652985ms","start":"2026-09-01T07:18:39.698072Z","end":"2026-09-01T07:18:39.869725Z","steps":["trace[1582851390] 'process raft request' (duration: 171.506372ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T07:18:39.875999Z","caller":"traceutil/trace.go:171","msg":"trace[1397364416] transaction","detail":"{read_only:false; response_revision:683; number_of_response:1; }","duration":"177.45489ms","start":"2026-09-01T07:18:39.69851Z","end":"2026-09-01T07:18:39.875965Z","steps":["trace[1397364416] 'process raft request' (duration: 177.222375ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T07:18:39.876177Z","caller":"traceutil/trace.go:171","msg":"trace[669898736] transaction","detail":"{read_only:false; response_revision:685; number_of_response:1; }","duration":"176.359376ms","start":"2026-09-01T07:18:39.699803Z","end":"2026-09-01T07:18:39.876163Z","steps":["trace[669898736] 'process raft request' (duration: 176.121881ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T07:18:39.876266Z","caller":"traceutil/trace.go:171","msg":"trace[567921737] transaction","detail":"{read_only:false; response_revision:686; number_of_response:1; }","duration":"175.424905ms","start":"2026-09-01T07:18:39.700806Z","end":"2026-09-01T07:18:39.876231Z","steps":["trace[567921737] 'process raft request' (duration: 175.240972ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T07:18:39.876335Z","caller":"traceutil/trace.go:171","msg":"trace[1127471884] transaction","detail":"{read_only:false; response_revision:684; number_of_response:1; }","duration":"176.918008ms","start":"2026-09-01T07:18:39.699368Z","end":"2026-09-01T07:18:39.876286Z","steps":["trace[1127471884] 'process raft request' (duration: 176.491789ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T07:18:39.876432Z","caller":"traceutil/trace.go:171","msg":"trace[1085831833] transaction","detail":"{read_only:false; response_revision:687; number_of_response:1; }","duration":"163.11987ms","start":"2026-09-01T07:18:39.7133Z","end":"2026-09-01T07:18:39.87642Z","steps":["trace[1085831833] 'process raft request' (duration: 162.799714ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T07:18:39.876164Z","caller":"traceutil/trace.go:171","msg":"trace[386793529] linearizableReadLoop","detail":"{readStateIndex:712; appliedIndex:706; }","duration":"138.075522ms","start":"2026-09-01T07:18:39.738069Z","end":"2026-09-01T07:18:39.876144Z","steps":["trace[386793529] 'read index received' (duration: 131.627343ms)","trace[386793529] 'applied index is now lower than readState.Index' (duration: 6.447179ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T07:18:39.876389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.309647ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-09-01T07:18:39.876686Z","caller":"traceutil/trace.go:171","msg":"trace[1234072388] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:687; }","duration":"138.659305ms","start":"2026-09-01T07:18:39.738013Z","end":"2026-09-01T07:18:39.876672Z","steps":["trace[1234072388] 'agreement among raft nodes before linearized reading' (duration: 138.218264ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T07:19:24.771833Z","caller":"traceutil/trace.go:171","msg":"trace[873314304] transaction","detail":"{read_only:false; response_revision:1197; number_of_response:1; }","duration":"110.251456ms","start":"2026-09-01T07:19:24.66156Z","end":"2026-09-01T07:19:24.771812Z","steps":["trace[873314304] 'process raft request' (duration: 110.096903ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T07:19:48.085323Z","caller":"traceutil/trace.go:171","msg":"trace[755025907] transaction","detail":"{read_only:false; response_revision:1457; number_of_response:1; }","duration":"192.618527ms","start":"2026-09-01T07:19:47.892678Z","end":"2026-09-01T07:19:48.085297Z","steps":["trace[755025907] 'process raft request' (duration: 192.415013ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T07:20:14.306161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.912199ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-01T07:20:14.306254Z","caller":"traceutil/trace.go:171","msg":"trace[392434571] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1882; }","duration":"176.069861ms","start":"2026-09-01T07:20:14.130163Z","end":"2026-09-01T07:20:14.306233Z","steps":["trace[392434571] 'range keys from in-memory index tree' (duration: 175.852737ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T07:20:14.306486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.795715ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-f68732cb-9a8e-43b3-aa9d-63acb80f2d55\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-09-01T07:20:14.306599Z","caller":"traceutil/trace.go:171","msg":"trace[1016120199] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-f68732cb-9a8e-43b3-aa9d-63acb80f2d55; range_end:; response_count:1; response_revision:1882; }","duration":"229.956267ms","start":"2026-09-01T07:20:14.076622Z","end":"2026-09-01T07:20:14.306578Z","steps":["trace[1016120199] 'range keys from in-memory index tree' (duration: 229.402447ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T07:20:14.68042Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.236287ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-01T07:20:14.680544Z","caller":"traceutil/trace.go:171","msg":"trace[1532237973] linearizableReadLoop","detail":"{readStateIndex:1957; appliedIndex:1956; }","duration":"114.919142ms","start":"2026-09-01T07:20:14.565608Z","end":"2026-09-01T07:20:14.680528Z","steps":["trace[1532237973] 'read index received' (duration: 49.851µs)","trace[1532237973] 'applied index is now lower than readState.Index' (duration: 114.868111ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T07:20:14.680561Z","caller":"traceutil/trace.go:171","msg":"trace[2124138579] transaction","detail":"{read_only:false; response_revision:1884; number_of_response:1; }","duration":"277.643045ms","start":"2026-09-01T07:20:14.402891Z","end":"2026-09-01T07:20:14.680534Z","steps":["trace[2124138579] 'compare' (duration: 267.130995ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T07:20:14.680718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.107258ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-09-01T07:20:14.680747Z","caller":"traceutil/trace.go:171","msg":"trace[1844760412] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1884; }","duration":"115.19035ms","start":"2026-09-01T07:20:14.565548Z","end":"2026-09-01T07:20:14.680739Z","steps":["trace[1844760412] 'agreement among raft nodes before linearized reading' (duration: 115.062847ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T07:20:14.68107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.561496ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-09-01T07:20:14.681151Z","caller":"traceutil/trace.go:171","msg":"trace[1781700669] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1884; }","duration":"114.674018ms","start":"2026-09-01T07:20:14.566458Z","end":"2026-09-01T07:20:14.681132Z","steps":["trace[1781700669] 'agreement among raft nodes before linearized reading' (duration: 114.448513ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T07:22:39.444816Z","caller":"traceutil/trace.go:171","msg":"trace[684863677] transaction","detail":"{read_only:false; response_revision:2906; number_of_response:1; }","duration":"132.003431ms","start":"2026-09-01T07:22:39.31278Z","end":"2026-09-01T07:22:39.444784Z","steps":["trace[684863677] 'process raft request' (duration: 129.946027ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T07:25:51.859447Z","caller":"traceutil/trace.go:171","msg":"trace[277512759] transaction","detail":"{read_only:false; response_revision:4125; number_of_response:1; }","duration":"171.628902ms","start":"2026-09-01T07:25:51.687785Z","end":"2026-09-01T07:25:51.859414Z","steps":["trace[277512759] 'process raft request' (duration: 171.402847ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T07:27:22.687102Z","caller":"traceutil/trace.go:171","msg":"trace[459664395] linearizableReadLoop","detail":"{readStateIndex:5537; appliedIndex:5536; }","duration":"165.064397ms","start":"2026-09-01T07:27:22.522013Z","end":"2026-09-01T07:27:22.687078Z","steps":["trace[459664395] 'read index received' (duration: 164.876323ms)","trace[459664395] 'applied index is now lower than readState.Index' (duration: 187.194µs)"],"step_count":2} {"level":"info","ts":"2026-09-01T07:27:22.687225Z","caller":"traceutil/trace.go:171","msg":"trace[488162765] transaction","detail":"{read_only:false; response_revision:5335; number_of_response:1; }","duration":"186.808776ms","start":"2026-09-01T07:27:22.500383Z","end":"2026-09-01T07:27:22.687192Z","steps":["trace[488162765] 'process raft request' (duration: 186.525ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T07:27:22.687371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.342053ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-426a8890-30f9-49e6-a9b2-d0ea13930d9c\" ","response":"range_response_count:1 size:3601"} {"level":"info","ts":"2026-09-01T07:27:22.687414Z","caller":"traceutil/trace.go:171","msg":"trace[1509213628] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-426a8890-30f9-49e6-a9b2-d0ea13930d9c; range_end:; response_count:1; response_revision:5335; }","duration":"165.442705ms","start":"2026-09-01T07:27:22.521959Z","end":"2026-09-01T07:27:22.687402Z","steps":["trace[1509213628] 'agreement among raft nodes before linearized reading' (duration: 165.254511ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T07:27:22.764316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.172721ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-prometheus-node-exporter-knj7t-tls\" ","response":"range_response_count:1 size:4432"} {"level":"info","ts":"2026-09-01T07:27:22.764411Z","caller":"traceutil/trace.go:171","msg":"trace[664437558] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-prometheus-node-exporter-knj7t-tls; range_end:; response_count:1; response_revision:5337; }","duration":"190.312024ms","start":"2026-09-01T07:27:22.574073Z","end":"2026-09-01T07:27:22.764385Z","steps":["trace[664437558] 'agreement among raft nodes before linearized reading' (duration: 190.11448ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T07:27:23.091374Z","caller":"traceutil/trace.go:171","msg":"trace[1044082325] transaction","detail":"{read_only:false; response_revision:5342; number_of_response:1; }","duration":"118.629095ms","start":"2026-09-01T07:27:22.972715Z","end":"2026-09-01T07:27:23.091345Z","steps":["trace[1044082325] 'process raft request' (duration: 49.90511ms)","trace[1044082325] 'compare' (duration: 68.611042ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T07:27:23.127828Z","caller":"traceutil/trace.go:171","msg":"trace[987729815] linearizableReadLoop","detail":"{readStateIndex:5545; appliedIndex:5543; }","duration":"139.661677ms","start":"2026-09-01T07:27:22.988138Z","end":"2026-09-01T07:27:23.1278Z","steps":["trace[987729815] 'read index received' (duration: 34.496269ms)","trace[987729815] 'applied index is now lower than readState.Index' (duration: 105.163988ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T07:27:23.127953Z","caller":"traceutil/trace.go:171","msg":"trace[27880538] transaction","detail":"{read_only:false; response_revision:5343; number_of_response:1; }","duration":"155.18681ms","start":"2026-09-01T07:27:22.972749Z","end":"2026-09-01T07:27:23.127936Z","steps":["trace[27880538] 'process raft request' (duration: 154.892834ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T07:27:23.128186Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.031996ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-09-01T07:27:23.128263Z","caller":"traceutil/trace.go:171","msg":"trace[521007727] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5343; }","duration":"140.161059ms","start":"2026-09-01T07:27:22.988084Z","end":"2026-09-01T07:27:23.128245Z","steps":["trace[521007727] 'agreement among raft nodes before linearized reading' (duration: 139.940874ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T07:27:40.108834Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2915} {"level":"info","ts":"2026-09-01T07:27:40.193623Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2915,"took":"83.351868ms","hash":3154522538,"current-db-size-bytes":56078336,"current-db-size":"56 MB","current-db-size-in-use-bytes":31223808,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-09-01T07:27:40.19369Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3154522538,"revision":2915,"compact-revision":-1} {"level":"info","ts":"2026-09-01T07:32:40.115615Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5624} {"level":"info","ts":"2026-09-01T07:32:40.205605Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5624,"took":"87.975419ms","hash":537901536,"current-db-size-bytes":56078336,"current-db-size":"56 MB","current-db-size-in-use-bytes":26628096,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-09-01T07:32:40.205675Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":537901536,"revision":5624,"compact-revision":2915} {"level":"info","ts":"2026-09-01T07:34:04.722517Z","caller":"traceutil/trace.go:171","msg":"trace[71544309] transaction","detail":"{read_only:false; response_revision:8650; number_of_response:1; }","duration":"224.305375ms","start":"2026-09-01T07:34:04.498181Z","end":"2026-09-01T07:34:04.722487Z","steps":["trace[71544309] 'process raft request' (duration: 224.12045ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T07:34:04.885323Z","caller":"traceutil/trace.go:171","msg":"trace[970502514] transaction","detail":"{read_only:false; response_revision:8651; number_of_response:1; }","duration":"383.724642ms","start":"2026-09-01T07:34:04.501565Z","end":"2026-09-01T07:34:04.88529Z","steps":["trace[970502514] 'process raft request' (duration: 383.277192ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T07:34:04.885563Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T07:34:04.501553Z","time spent":"383.856664ms","remote":"127.0.0.1:34502","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-01T07:34:04.885606Z","caller":"traceutil/trace.go:171","msg":"trace[1445965130] transaction","detail":"{read_only:false; response_revision:8652; number_of_response:1; }","duration":"330.943133ms","start":"2026-09-01T07:34:04.554602Z","end":"2026-09-01T07:34:04.885545Z","steps":["trace[1445965130] 'process raft request' (duration: 330.634357ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T07:34:04.885647Z","caller":"traceutil/trace.go:171","msg":"trace[1362730015] linearizableReadLoop","detail":"{readStateIndex:8960; appliedIndex:8956; }","duration":"164.627702ms","start":"2026-09-01T07:34:04.720988Z","end":"2026-09-01T07:34:04.885616Z","steps":["trace[1362730015] 'read index received' (duration: 1.39242ms)","trace[1362730015] 'applied index is now lower than readState.Index' (duration: 163.234142ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T07:34:04.885817Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T07:34:04.554589Z","time spent":"331.108107ms","remote":"127.0.0.1:34502","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-01T07:34:04.885909Z","caller":"traceutil/trace.go:171","msg":"trace[1707158904] transaction","detail":"{read_only:false; response_revision:8653; number_of_response:1; }","duration":"327.457145ms","start":"2026-09-01T07:34:04.558437Z","end":"2026-09-01T07:34:04.885894Z","steps":["trace[1707158904] 'process raft request' (duration: 327.039656ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T07:34:04.88605Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T07:34:04.558403Z","time spent":"327.547217ms","remote":"127.0.0.1:34502","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-01T07:34:04.886129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.122334ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-01T07:34:04.886177Z","caller":"traceutil/trace.go:171","msg":"trace[809245827] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:8653; }","duration":"165.250407ms","start":"2026-09-01T07:34:04.720911Z","end":"2026-09-01T07:34:04.886162Z","steps":["trace[809245827] 'agreement among raft nodes before linearized reading' (duration: 165.072602ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T07:34:17.125703Z","caller":"traceutil/trace.go:171","msg":"trace[837853559] transaction","detail":"{read_only:false; response_revision:8714; number_of_response:1; }","duration":"169.875021ms","start":"2026-09-01T07:34:16.955799Z","end":"2026-09-01T07:34:17.125674Z","steps":["trace[837853559] 'process raft request' (duration: 169.663296ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T07:34:17.125869Z","caller":"traceutil/trace.go:171","msg":"trace[159294098] transaction","detail":"{read_only:false; response_revision:8715; number_of_response:1; }","duration":"169.955292ms","start":"2026-09-01T07:34:16.955869Z","end":"2026-09-01T07:34:17.125825Z","steps":["trace[159294098] 'process raft request' (duration: 169.764838ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T07:34:41.879511Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000023f3.wal"} {"level":"info","ts":"2026-09-01T07:34:59.804733Z","caller":"traceutil/trace.go:171","msg":"trace[1830900377] linearizableReadLoop","detail":"{readStateIndex:9327; appliedIndex:9326; }","duration":"126.632516ms","start":"2026-09-01T07:34:59.678073Z","end":"2026-09-01T07:34:59.804705Z","steps":["trace[1830900377] 'read index received' (duration: 126.32826ms)","trace[1830900377] 'applied index is now lower than readState.Index' (duration: 303.106µs)"],"step_count":2} {"level":"info","ts":"2026-09-01T07:34:59.805096Z","caller":"traceutil/trace.go:171","msg":"trace[1173881501] transaction","detail":"{read_only:false; response_revision:9007; number_of_response:1; }","duration":"134.573047ms","start":"2026-09-01T07:34:59.67051Z","end":"2026-09-01T07:34:59.805083Z","steps":["trace[1173881501] 'process raft request' (duration: 133.994545ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T07:34:59.805357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.493367ms","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-09-01T07:34:59.805407Z","caller":"traceutil/trace.go:171","msg":"trace[433943381] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:9007; }","duration":"122.59578ms","start":"2026-09-01T07:34:59.682799Z","end":"2026-09-01T07:34:59.805395Z","steps":["trace[433943381] 'agreement among raft nodes before linearized reading' (duration: 122.480897ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T07:34:59.805571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.448713ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-01T07:34:59.805677Z","caller":"traceutil/trace.go:171","msg":"trace[1381411586] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:9007; }","duration":"127.652689ms","start":"2026-09-01T07:34:59.678001Z","end":"2026-09-01T07:34:59.805654Z","steps":["trace[1381411586] 'agreement among raft nodes before linearized reading' (duration: 127.435285ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T07:34:59.805779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.960654ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-09-01T07:34:59.805862Z","caller":"traceutil/trace.go:171","msg":"trace[2013840668] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:9007; }","duration":"114.098306ms","start":"2026-09-01T07:34:59.691743Z","end":"2026-09-01T07:34:59.805841Z","steps":["trace[2013840668] 'agreement among raft nodes before linearized reading' (duration: 113.828111ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T07:34:59.926927Z","caller":"traceutil/trace.go:171","msg":"trace[503044321] linearizableReadLoop","detail":"{readStateIndex:9329; appliedIndex:9327; }","duration":"114.410373ms","start":"2026-09-01T07:34:59.812485Z","end":"2026-09-01T07:34:59.926896Z","steps":["trace[503044321] 'read index received' (duration: 110.383237ms)","trace[503044321] 'applied index is now lower than readState.Index' (duration: 4.026176ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T07:34:59.926965Z","caller":"traceutil/trace.go:171","msg":"trace[1814529438] transaction","detail":"{read_only:false; response_revision:9009; number_of_response:1; }","duration":"116.559639ms","start":"2026-09-01T07:34:59.810373Z","end":"2026-09-01T07:34:59.926933Z","steps":["trace[1814529438] 'process raft request' (duration: 116.469657ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T07:34:59.926984Z","caller":"traceutil/trace.go:171","msg":"trace[310977831] transaction","detail":"{read_only:false; response_revision:9008; number_of_response:1; }","duration":"116.565869ms","start":"2026-09-01T07:34:59.810371Z","end":"2026-09-01T07:34:59.926937Z","steps":["trace[310977831] 'process raft request' (duration: 112.481292ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T07:34:59.927268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.74664ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-dm9dk\" ","response":"range_response_count:1 size:4653"} {"level":"info","ts":"2026-09-01T07:34:59.927357Z","caller":"traceutil/trace.go:171","msg":"trace[1995974238] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-dm9dk; range_end:; response_count:1; response_revision:9009; }","duration":"114.892134ms","start":"2026-09-01T07:34:59.812443Z","end":"2026-09-01T07:34:59.927335Z","steps":["trace[1995974238] 'agreement among raft nodes before linearized reading' (duration: 114.565427ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T07:34:59.974506Z","caller":"traceutil/trace.go:171","msg":"trace[2126205145] transaction","detail":"{read_only:false; response_revision:9011; number_of_response:1; }","duration":"161.847854ms","start":"2026-09-01T07:34:59.812628Z","end":"2026-09-01T07:34:59.974476Z","steps":["trace[2126205145] 'process raft request' (duration: 161.756002ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T07:34:59.974574Z","caller":"traceutil/trace.go:171","msg":"trace[1417986830] transaction","detail":"{read_only:false; response_revision:9010; number_of_response:1; }","duration":"161.920926ms","start":"2026-09-01T07:34:59.812609Z","end":"2026-09-01T07:34:59.97453Z","steps":["trace[1417986830] 'process raft request' (duration: 161.63123ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T07:34:59.974925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.75324ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/sshkeys/\" range_end:\"/registry/secretgen.k14s.io/sshkeys0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-01T07:34:59.974979Z","caller":"traceutil/trace.go:171","msg":"trace[2065013165] range","detail":"{range_begin:/registry/secretgen.k14s.io/sshkeys/; range_end:/registry/secretgen.k14s.io/sshkeys0; response_count:0; response_revision:9012; }","duration":"101.909964ms","start":"2026-09-01T07:34:59.873054Z","end":"2026-09-01T07:34:59.974964Z","steps":["trace[2065013165] 'agreement among raft nodes before linearized reading' (duration: 101.797152ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T07:34:59.976485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.458496ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-09-01T07:34:59.976667Z","caller":"traceutil/trace.go:171","msg":"trace[772108842] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:9012; }","duration":"161.683721ms","start":"2026-09-01T07:34:59.814951Z","end":"2026-09-01T07:34:59.976635Z","steps":["trace[772108842] 'agreement among raft nodes before linearized reading' (duration: 159.816381ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T07:36:01.727737Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"d232699cb6c87299","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-09-01T07:36:01.733622Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-09-01T07:36:01.733709Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-09-01T07:37:40.122774Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":7974} {"level":"info","ts":"2026-09-01T07:37:40.210257Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":7974,"took":"84.851281ms","hash":1882773339,"current-db-size-bytes":56078336,"current-db-size":"56 MB","current-db-size-in-use-bytes":24821760,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-09-01T07:37:40.210423Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1882773339,"revision":7974,"compact-revision":5624} {"level":"info","ts":"2026-09-01T07:42:12.625576Z","caller":"traceutil/trace.go:171","msg":"trace[849395501] linearizableReadLoop","detail":"{readStateIndex:12732; appliedIndex:12731; }","duration":"184.823292ms","start":"2026-09-01T07:42:12.440719Z","end":"2026-09-01T07:42:12.625542Z","steps":["trace[849395501] 'read index received' (duration: 184.681789ms)","trace[849395501] 'applied index is now lower than readState.Index' (duration: 139.873µs)"],"step_count":2} {"level":"info","ts":"2026-09-01T07:42:12.625658Z","caller":"traceutil/trace.go:171","msg":"trace[218300084] transaction","detail":"{read_only:false; response_revision:12307; number_of_response:1; }","duration":"208.939578ms","start":"2026-09-01T07:42:12.416671Z","end":"2026-09-01T07:42:12.625611Z","steps":["trace[218300084] 'process raft request' (duration: 208.667002ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T07:42:12.625934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.18902ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-09-01T07:42:12.626002Z","caller":"traceutil/trace.go:171","msg":"trace[255871712] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:12307; }","duration":"185.324563ms","start":"2026-09-01T07:42:12.440659Z","end":"2026-09-01T07:42:12.625984Z","steps":["trace[255871712] 'agreement among raft nodes before linearized reading' (duration: 185.041967ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T07:42:12.638075Z","caller":"traceutil/trace.go:171","msg":"trace[981755707] transaction","detail":"{read_only:false; response_revision:12308; number_of_response:1; }","duration":"154.25767ms","start":"2026-09-01T07:42:12.483777Z","end":"2026-09-01T07:42:12.638035Z","steps":["trace[981755707] 'process raft request' (duration: 153.993383ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T07:42:12.638155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.872648ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-09-01T07:42:12.63822Z","caller":"traceutil/trace.go:171","msg":"trace[556010360] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:12308; }","duration":"187.976399ms","start":"2026-09-01T07:42:12.450225Z","end":"2026-09-01T07:42:12.638201Z","steps":["trace[556010360] 'agreement among raft nodes before linearized reading' (duration: 187.732224ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T07:42:12.63827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.032589ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-09-01T07:42:12.638345Z","caller":"traceutil/trace.go:171","msg":"trace[1430417346] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:12308; }","duration":"187.163923ms","start":"2026-09-01T07:42:12.45116Z","end":"2026-09-01T07:42:12.638324Z","steps":["trace[1430417346] 'agreement among raft nodes before linearized reading' (duration: 186.929288ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T07:42:40.131249Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10341} {"level":"info","ts":"2026-09-01T07:42:40.221007Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10341,"took":"86.250704ms","hash":926639013,"current-db-size-bytes":56078336,"current-db-size":"56 MB","current-db-size-in-use-bytes":25710592,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-09-01T07:42:40.221162Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":926639013,"revision":10341,"compact-revision":7974} {"level":"info","ts":"2026-09-01T07:47:40.139422Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12506} {"level":"info","ts":"2026-09-01T07:47:40.224542Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12506,"took":"82.140537ms","hash":973207787,"current-db-size-bytes":56078336,"current-db-size":"56 MB","current-db-size-in-use-bytes":27869184,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-09-01T07:47:40.224616Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":973207787,"revision":12506,"compact-revision":10341} {"level":"info","ts":"2026-09-01T07:48:54.139179Z","caller":"traceutil/trace.go:171","msg":"trace[1468822485] transaction","detail":"{read_only:false; response_revision:14987; number_of_response:1; }","duration":"140.919603ms","start":"2026-09-01T07:48:53.99821Z","end":"2026-09-01T07:48:54.13913Z","steps":["trace[1468822485] 'process raft request' (duration: 140.723349ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T07:49:04.914434Z","caller":"traceutil/trace.go:171","msg":"trace[679179470] transaction","detail":"{read_only:false; response_revision:15161; number_of_response:1; }","duration":"105.658632ms","start":"2026-09-01T07:49:04.808729Z","end":"2026-09-01T07:49:04.914388Z","steps":["trace[679179470] 'process raft request' (duration: 26.120915ms)","trace[679179470] 'compare' (duration: 79.040886ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T07:49:05.220417Z","caller":"traceutil/trace.go:171","msg":"trace[292910336] linearizableReadLoop","detail":"{readStateIndex:15692; appliedIndex:15691; }","duration":"169.255073ms","start":"2026-09-01T07:49:05.051138Z","end":"2026-09-01T07:49:05.220393Z","steps":["trace[292910336] 'read index received' (duration: 77.156745ms)","trace[292910336] 'applied index is now lower than readState.Index' (duration: 92.097588ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T07:49:05.220497Z","caller":"traceutil/trace.go:171","msg":"trace[1225763444] transaction","detail":"{read_only:false; response_revision:15166; number_of_response:1; }","duration":"257.349335ms","start":"2026-09-01T07:49:04.963107Z","end":"2026-09-01T07:49:05.220456Z","steps":["trace[1225763444] 'process raft request' (duration: 165.260167ms)","trace[1225763444] 'compare' (duration: 91.914595ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T07:49:05.220702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.519509ms","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-09-01T07:49:05.220734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.362845ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-09-01T07:49:05.220796Z","caller":"traceutil/trace.go:171","msg":"trace[522178543] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:15166; }","duration":"169.686042ms","start":"2026-09-01T07:49:05.051088Z","end":"2026-09-01T07:49:05.220774Z","steps":["trace[522178543] 'agreement among raft nodes before linearized reading' (duration: 169.390226ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T07:49:05.22083Z","caller":"traceutil/trace.go:171","msg":"trace[2124242969] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:15166; }","duration":"169.520719ms","start":"2026-09-01T07:49:05.051274Z","end":"2026-09-01T07:49:05.220794Z","steps":["trace[2124242969] 'agreement among raft nodes before linearized reading' (duration: 169.282824ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T07:49:05.221015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.741345ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-09-01T07:49:05.221081Z","caller":"traceutil/trace.go:171","msg":"trace[369205846] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:15166; }","duration":"169.843617ms","start":"2026-09-01T07:49:05.051213Z","end":"2026-09-01T07:49:05.221057Z","steps":["trace[369205846] 'agreement among raft nodes before linearized reading' (duration: 169.311025ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T07:49:05.221094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.194023ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-09-01T07:49:05.221128Z","caller":"traceutil/trace.go:171","msg":"trace[2067403887] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:15166; }","duration":"169.250285ms","start":"2026-09-01T07:49:05.051868Z","end":"2026-09-01T07:49:05.221119Z","steps":["trace[2067403887] 'agreement among raft nodes before linearized reading' (duration: 168.678881ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T07:49:05.368964Z","caller":"traceutil/trace.go:171","msg":"trace[1696909934] linearizableReadLoop","detail":"{readStateIndex:15693; appliedIndex:15692; }","duration":"143.817685ms","start":"2026-09-01T07:49:05.225122Z","end":"2026-09-01T07:49:05.36894Z","steps":["trace[1696909934] 'read index received' (duration: 106.816136ms)","trace[1696909934] 'applied index is now lower than readState.Index' (duration: 37.000879ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T07:49:05.36904Z","caller":"traceutil/trace.go:171","msg":"trace[615776523] transaction","detail":"{read_only:false; response_revision:15167; number_of_response:1; }","duration":"144.706623ms","start":"2026-09-01T07:49:05.224282Z","end":"2026-09-01T07:49:05.368988Z","steps":["trace[615776523] 'process raft request' (duration: 107.674974ms)","trace[615776523] 'compare' (duration: 36.862585ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T07:49:05.369192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.043459ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-09-01T07:49:05.369222Z","caller":"traceutil/trace.go:171","msg":"trace[1058755040] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:15167; }","duration":"144.233184ms","start":"2026-09-01T07:49:05.224981Z","end":"2026-09-01T07:49:05.369214Z","steps":["trace[1058755040] 'agreement among raft nodes before linearized reading' (duration: 144.04013ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T07:49:05.369536Z","caller":"traceutil/trace.go:171","msg":"trace[1309782702] transaction","detail":"{read_only:false; response_revision:15169; number_of_response:1; }","duration":"143.324305ms","start":"2026-09-01T07:49:05.226197Z","end":"2026-09-01T07:49:05.369521Z","steps":["trace[1309782702] 'process raft request' (duration: 143.10273ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T07:49:05.369646Z","caller":"traceutil/trace.go:171","msg":"trace[1130135364] transaction","detail":"{read_only:false; response_revision:15168; number_of_response:1; }","duration":"143.724824ms","start":"2026-09-01T07:49:05.225912Z","end":"2026-09-01T07:49:05.369637Z","steps":["trace[1130135364] 'process raft request' (duration: 143.257473ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T07:49:05.36968Z","caller":"traceutil/trace.go:171","msg":"trace[324944424] transaction","detail":"{read_only:false; response_revision:15170; number_of_response:1; }","duration":"143.394017ms","start":"2026-09-01T07:49:05.226276Z","end":"2026-09-01T07:49:05.36967Z","steps":["trace[324944424] 'process raft request' (duration: 143.060508ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T07:49:05.369733Z","caller":"traceutil/trace.go:171","msg":"trace[124631921] transaction","detail":"{read_only:false; response_revision:15171; number_of_response:1; }","duration":"141.038656ms","start":"2026-09-01T07:49:05.228686Z","end":"2026-09-01T07:49:05.369725Z","steps":["trace[124631921] 'process raft request' (duration: 140.694908ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T07:50:13.45971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.96929ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-09-01T07:50:13.459853Z","caller":"traceutil/trace.go:171","msg":"trace[643385597] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:16088; }","duration":"138.160605ms","start":"2026-09-01T07:50:13.32167Z","end":"2026-09-01T07:50:13.459831Z","steps":["trace[643385597] 'range keys from in-memory index tree' (duration: 137.766267ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T07:50:46.867181Z","caller":"traceutil/trace.go:171","msg":"trace[719916779] transaction","detail":"{read_only:false; response_revision:16263; number_of_response:1; }","duration":"120.847346ms","start":"2026-09-01T07:50:46.746308Z","end":"2026-09-01T07:50:46.867155Z","steps":["trace[719916779] 'process raft request' (duration: 120.701593ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T07:50:52.194799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.628832ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-01T07:50:52.194918Z","caller":"traceutil/trace.go:171","msg":"trace[683110751] linearizableReadLoop","detail":"{readStateIndex:16856; appliedIndex:16855; }","duration":"193.873836ms","start":"2026-09-01T07:50:52.001028Z","end":"2026-09-01T07:50:52.194902Z","steps":["trace[683110751] 'read index received' (duration: 11.945108ms)","trace[683110751] 'applied index is now lower than readState.Index' (duration: 181.927598ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T07:50:52.194949Z","caller":"traceutil/trace.go:171","msg":"trace[208622238] transaction","detail":"{read_only:false; response_revision:16292; number_of_response:1; }","duration":"202.436412ms","start":"2026-09-01T07:50:51.992487Z","end":"2026-09-01T07:50:52.194923Z","steps":["trace[208622238] 'process raft request' (duration: 20.567835ms)","trace[208622238] 'compare' (duration: 181.49889ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T07:50:52.195176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.127701ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-09-01T07:50:52.195266Z","caller":"traceutil/trace.go:171","msg":"trace[356591233] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:16292; }","duration":"194.221884ms","start":"2026-09-01T07:50:52.001021Z","end":"2026-09-01T07:50:52.195243Z","steps":["trace[356591233] 'agreement among raft nodes before linearized reading' (duration: 193.983919ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T07:50:52.196668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.19392ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-sr6fd\" ","response":"range_response_count:1 size:9709"} {"level":"info","ts":"2026-09-01T07:50:52.19673Z","caller":"traceutil/trace.go:171","msg":"trace[381700905] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-sr6fd; range_end:; response_count:1; response_revision:16292; }","duration":"174.273353ms","start":"2026-09-01T07:50:52.022439Z","end":"2026-09-01T07:50:52.196712Z","steps":["trace[381700905] 'agreement among raft nodes before linearized reading' (duration: 173.032466ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T07:52:40.148239Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14509} {"level":"info","ts":"2026-09-01T07:52:40.23057Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14509,"took":"79.459013ms","hash":2163003897,"current-db-size-bytes":56078336,"current-db-size":"56 MB","current-db-size-in-use-bytes":31158272,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-09-01T07:52:40.230651Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2163003897,"revision":14509,"compact-revision":12506} {"level":"info","ts":"2026-09-01T07:52:58.27452Z","caller":"traceutil/trace.go:171","msg":"trace[434732216] transaction","detail":"{read_only:false; response_revision:17155; number_of_response:1; }","duration":"125.311611ms","start":"2026-09-01T07:52:58.149182Z","end":"2026-09-01T07:52:58.274493Z","steps":["trace[434732216] 'process raft request' (duration: 125.136257ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T07:52:58.42043Z","caller":"traceutil/trace.go:171","msg":"trace[828082563] transaction","detail":"{read_only:false; response_revision:17157; number_of_response:1; }","duration":"138.668934ms","start":"2026-09-01T07:52:58.2817Z","end":"2026-09-01T07:52:58.420369Z","steps":["trace[828082563] 'process raft request' (duration: 105.536041ms)","trace[828082563] 'compare' (duration: 32.896908ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T07:52:58.420479Z","caller":"traceutil/trace.go:171","msg":"trace[568394689] transaction","detail":"{read_only:false; response_revision:17158; number_of_response:1; }","duration":"137.870917ms","start":"2026-09-01T07:52:58.282574Z","end":"2026-09-01T07:52:58.420445Z","steps":["trace[568394689] 'process raft request' (duration: 137.701463ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T07:52:58.420728Z","caller":"traceutil/trace.go:171","msg":"trace[606164905] transaction","detail":"{read_only:false; response_revision:17159; number_of_response:1; }","duration":"135.268071ms","start":"2026-09-01T07:52:58.28545Z","end":"2026-09-01T07:52:58.420718Z","steps":["trace[606164905] 'process raft request' (duration: 134.929614ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T07:52:58.421026Z","caller":"traceutil/trace.go:171","msg":"trace[374398959] transaction","detail":"{read_only:false; response_revision:17160; number_of_response:1; }","duration":"127.696712ms","start":"2026-09-01T07:52:58.293318Z","end":"2026-09-01T07:52:58.421015Z","steps":["trace[374398959] 'process raft request' (duration: 127.272162ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T07:52:59.658341Z","caller":"traceutil/trace.go:171","msg":"trace[1051011] transaction","detail":"{read_only:false; response_revision:17171; number_of_response:1; }","duration":"106.511721ms","start":"2026-09-01T07:52:59.551805Z","end":"2026-09-01T07:52:59.658317Z","steps":["trace[1051011] 'process raft request' (duration: 106.318897ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T07:53:00.13407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.211733ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-09-01T07:53:00.134341Z","caller":"traceutil/trace.go:171","msg":"trace[883194299] transaction","detail":"{read_only:false; response_revision:17174; number_of_response:1; }","duration":"218.833996ms","start":"2026-09-01T07:52:59.915424Z","end":"2026-09-01T07:53:00.134258Z","steps":["trace[883194299] 'process raft request' (duration: 16.313137ms)","trace[883194299] 'compare' (duration: 202.07184ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T07:53:00.134421Z","caller":"traceutil/trace.go:171","msg":"trace[949399563] transaction","detail":"{read_only:false; response_revision:17175; number_of_response:1; }","duration":"218.56976ms","start":"2026-09-01T07:52:59.915828Z","end":"2026-09-01T07:53:00.134398Z","steps":["trace[949399563] 'process raft request' (duration: 218.341575ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T07:53:01.797198Z","caller":"traceutil/trace.go:171","msg":"trace[664617443] linearizableReadLoop","detail":"{readStateIndex:17779; appliedIndex:17778; }","duration":"121.004169ms","start":"2026-09-01T07:53:01.676165Z","end":"2026-09-01T07:53:01.797169Z","steps":["trace[664617443] 'read index received' (duration: 120.792035ms)","trace[664617443] 'applied index is now lower than readState.Index' (duration: 208.034µs)"],"step_count":2} {"level":"info","ts":"2026-09-01T07:53:01.797231Z","caller":"traceutil/trace.go:171","msg":"trace[2001788134] transaction","detail":"{read_only:false; response_revision:17182; number_of_response:1; }","duration":"133.692219ms","start":"2026-09-01T07:53:01.663496Z","end":"2026-09-01T07:53:01.797189Z","steps":["trace[2001788134] 'process raft request' (duration: 133.496185ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T07:53:01.797401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.211454ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-09-01T07:53:01.797455Z","caller":"traceutil/trace.go:171","msg":"trace[1083995133] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:17182; }","duration":"121.281705ms","start":"2026-09-01T07:53:01.676158Z","end":"2026-09-01T07:53:01.79744Z","steps":["trace[1083995133] 'agreement among raft nodes before linearized reading' (duration: 121.109812ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T07:53:01.931551Z","caller":"traceutil/trace.go:171","msg":"trace[2085710470] transaction","detail":"{read_only:false; response_revision:17184; number_of_response:1; }","duration":"107.768079ms","start":"2026-09-01T07:53:01.823746Z","end":"2026-09-01T07:53:01.931514Z","steps":["trace[2085710470] 'process raft request' (duration: 35.7546ms)","trace[2085710470] 'compare' (duration: 71.875876ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T07:53:01.949918Z","caller":"traceutil/trace.go:171","msg":"trace[235682035] linearizableReadLoop","detail":"{readStateIndex:17782; appliedIndex:17780; }","duration":"107.864569ms","start":"2026-09-01T07:53:01.842029Z","end":"2026-09-01T07:53:01.949894Z","steps":["trace[235682035] 'read index received' (duration: 17.565033ms)","trace[235682035] 'applied index is now lower than readState.Index' (duration: 90.297906ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T07:53:01.950012Z","caller":"traceutil/trace.go:171","msg":"trace[1136703995] transaction","detail":"{read_only:false; response_revision:17185; number_of_response:1; }","duration":"117.431853ms","start":"2026-09-01T07:53:01.832551Z","end":"2026-09-01T07:53:01.949982Z","steps":["trace[1136703995] 'process raft request' (duration: 117.190708ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T07:53:01.950103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.060334ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/nfd.k8s-sigs.io/nodefeaturerules/\" range_end:\"/registry/nfd.k8s-sigs.io/nodefeaturerules0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-01T07:53:01.95015Z","caller":"traceutil/trace.go:171","msg":"trace[1785358122] range","detail":"{range_begin:/registry/nfd.k8s-sigs.io/nodefeaturerules/; range_end:/registry/nfd.k8s-sigs.io/nodefeaturerules0; response_count:0; response_revision:17185; }","duration":"108.125505ms","start":"2026-09-01T07:53:01.842012Z","end":"2026-09-01T07:53:01.950138Z","steps":["trace[1785358122] 'agreement among raft nodes before linearized reading' (duration: 108.031334ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T07:53:01.986362Z","caller":"traceutil/trace.go:171","msg":"trace[1862485040] transaction","detail":"{read_only:false; response_revision:17186; number_of_response:1; }","duration":"112.000598ms","start":"2026-09-01T07:53:01.874337Z","end":"2026-09-01T07:53:01.986338Z","steps":["trace[1862485040] 'process raft request' (duration: 111.716252ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T07:53:02.287975Z","caller":"traceutil/trace.go:171","msg":"trace[788174212] transaction","detail":"{read_only:false; response_revision:17188; number_of_response:1; }","duration":"146.805077ms","start":"2026-09-01T07:53:02.141125Z","end":"2026-09-01T07:53:02.28793Z","steps":["trace[788174212] 'process raft request' (duration: 146.553612ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T07:53:03.146776Z","caller":"traceutil/trace.go:171","msg":"trace[939302239] linearizableReadLoop","detail":"{readStateIndex:17795; appliedIndex:17793; }","duration":"148.525654ms","start":"2026-09-01T07:53:02.998232Z","end":"2026-09-01T07:53:03.146757Z","steps":["trace[939302239] 'read index received' (duration: 9.88819ms)","trace[939302239] 'applied index is now lower than readState.Index' (duration: 138.636544ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T07:53:03.147025Z","caller":"traceutil/trace.go:171","msg":"trace[1092002401] transaction","detail":"{read_only:false; response_revision:17198; number_of_response:1; }","duration":"151.418355ms","start":"2026-09-01T07:53:02.995593Z","end":"2026-09-01T07:53:03.147011Z","steps":["trace[1092002401] 'process raft request' (duration: 99.707866ms)","trace[1092002401] 'compare' (duration: 51.391911ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T07:53:03.147473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.2531ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-conductor-b8956b95d-vvgx5\" ","response":"range_response_count:1 size:7857"} {"level":"info","ts":"2026-09-01T07:53:03.147516Z","caller":"traceutil/trace.go:171","msg":"trace[2106874033] range","detail":"{range_begin:/registry/pods/openstack/nova-conductor-b8956b95d-vvgx5; range_end:; response_count:1; response_revision:17198; }","duration":"149.378732ms","start":"2026-09-01T07:53:02.998127Z","end":"2026-09-01T07:53:03.147506Z","steps":["trace[2106874033] 'agreement among raft nodes before linearized reading' (duration: 149.245699ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T07:53:03.147878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.388052ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:83 size:803880"} {"level":"info","ts":"2026-09-01T07:53:03.147949Z","caller":"traceutil/trace.go:171","msg":"trace[266351944] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:83; response_revision:17198; }","duration":"141.489775ms","start":"2026-09-01T07:53:03.006443Z","end":"2026-09-01T07:53:03.147932Z","steps":["trace[266351944] 'agreement among raft nodes before linearized reading' (duration: 140.605437ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T07:53:03.148895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.428502ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:83 size:803880"} {"level":"info","ts":"2026-09-01T07:53:03.148983Z","caller":"traceutil/trace.go:171","msg":"trace[1247909636] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:83; response_revision:17198; }","duration":"141.584206ms","start":"2026-09-01T07:53:03.007386Z","end":"2026-09-01T07:53:03.14897Z","steps":["trace[1247909636] 'agreement among raft nodes before linearized reading' (duration: 140.653916ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T07:53:04.08673Z","caller":"traceutil/trace.go:171","msg":"trace[1645141929] linearizableReadLoop","detail":"{readStateIndex:17803; appliedIndex:17802; }","duration":"267.273034ms","start":"2026-09-01T07:53:03.819433Z","end":"2026-09-01T07:53:04.086706Z","steps":["trace[1645141929] 'read index received' (duration: 267.119751ms)","trace[1645141929] 'applied index is now lower than readState.Index' (duration: 152.353µs)"],"step_count":2} {"level":"info","ts":"2026-09-01T07:53:04.086781Z","caller":"traceutil/trace.go:171","msg":"trace[1186627888] transaction","detail":"{read_only:false; response_revision:17205; number_of_response:1; }","duration":"278.764848ms","start":"2026-09-01T07:53:03.80799Z","end":"2026-09-01T07:53:04.086754Z","steps":["trace[1186627888] 'process raft request' (duration: 278.573084ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T07:53:04.086918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.479168ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-09-01T07:53:04.086967Z","caller":"traceutil/trace.go:171","msg":"trace[2005594726] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:17205; }","duration":"267.576311ms","start":"2026-09-01T07:53:03.819365Z","end":"2026-09-01T07:53:04.086941Z","steps":["trace[2005594726] 'agreement among raft nodes before linearized reading' (duration: 267.443818ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T07:53:04.11363Z","caller":"traceutil/trace.go:171","msg":"trace[1028313002] transaction","detail":"{read_only:false; response_revision:17206; number_of_response:1; }","duration":"121.737376ms","start":"2026-09-01T07:53:03.991864Z","end":"2026-09-01T07:53:04.113602Z","steps":["trace[1028313002] 'process raft request' (duration: 121.4627ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T07:53:04.113648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.032038ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-sr6fd\" ","response":"range_response_count:1 size:9710"} {"level":"info","ts":"2026-09-01T07:53:04.113721Z","caller":"traceutil/trace.go:171","msg":"trace[1711642424] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-sr6fd; range_end:; response_count:1; response_revision:17206; }","duration":"103.11878ms","start":"2026-09-01T07:53:04.010583Z","end":"2026-09-01T07:53:04.113702Z","steps":["trace[1711642424] 'agreement among raft nodes before linearized reading' (duration: 102.888615ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T07:53:04.238297Z","caller":"traceutil/trace.go:171","msg":"trace[930457443] transaction","detail":"{read_only:false; response_revision:17208; number_of_response:1; }","duration":"104.879906ms","start":"2026-09-01T07:53:04.133385Z","end":"2026-09-01T07:53:04.238265Z","steps":["trace[930457443] 'process raft request' (duration: 75.111454ms)","trace[930457443] 'compare' (duration: 29.287432ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T07:53:04.238291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.830975ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-bootstrap-4j9jg\" ","response":"range_response_count:1 size:8536"} {"level":"info","ts":"2026-09-01T07:53:04.238624Z","caller":"traceutil/trace.go:171","msg":"trace[487672947] range","detail":"{range_begin:/registry/pods/openstack/nova-bootstrap-4j9jg; range_end:; response_count:1; response_revision:17209; }","duration":"105.207293ms","start":"2026-09-01T07:53:04.133394Z","end":"2026-09-01T07:53:04.238601Z","steps":["trace[487672947] 'agreement among raft nodes before linearized reading' (duration: 104.706382ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T07:53:04.441712Z","caller":"traceutil/trace.go:171","msg":"trace[422732857] transaction","detail":"{read_only:false; response_revision:17211; number_of_response:1; }","duration":"148.643006ms","start":"2026-09-01T07:53:04.293047Z","end":"2026-09-01T07:53:04.44169Z","steps":["trace[422732857] 'process raft request' (duration: 148.499803ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T07:53:05.364499Z","caller":"traceutil/trace.go:171","msg":"trace[1435922362] linearizableReadLoop","detail":"{readStateIndex:17815; appliedIndex:17813; }","duration":"196.38673ms","start":"2026-09-01T07:53:05.168083Z","end":"2026-09-01T07:53:05.36447Z","steps":["trace[1435922362] 'read index received' (duration: 64.99906ms)","trace[1435922362] 'applied index is now lower than readState.Index' (duration: 131.38647ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T07:53:05.364808Z","caller":"traceutil/trace.go:171","msg":"trace[181959698] transaction","detail":"{read_only:false; response_revision:17217; number_of_response:1; }","duration":"199.959355ms","start":"2026-09-01T07:53:05.16483Z","end":"2026-09-01T07:53:05.36479Z","steps":["trace[181959698] 'process raft request' (duration: 190.916553ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T07:53:05.36515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.041804ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-9vg6j\" ","response":"range_response_count:1 size:22015"} {"level":"info","ts":"2026-09-01T07:53:05.365218Z","caller":"traceutil/trace.go:171","msg":"trace[44624444] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-9vg6j; range_end:; response_count:1; response_revision:17217; }","duration":"197.145035ms","start":"2026-09-01T07:53:05.168054Z","end":"2026-09-01T07:53:05.365199Z","steps":["trace[44624444] 'agreement among raft nodes before linearized reading' (duration: 196.913051ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T07:53:05.402505Z","caller":"traceutil/trace.go:171","msg":"trace[43285702] transaction","detail":"{read_only:false; response_revision:17218; number_of_response:1; }","duration":"105.573532ms","start":"2026-09-01T07:53:05.296909Z","end":"2026-09-01T07:53:05.402482Z","steps":["trace[43285702] 'process raft request' (duration: 105.200844ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T07:53:05.402636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.192013ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-9vg6j\" ","response":"range_response_count:1 size:22015"} {"level":"info","ts":"2026-09-01T07:53:05.402698Z","caller":"traceutil/trace.go:171","msg":"trace[1667787785] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-9vg6j; range_end:; response_count:1; response_revision:17218; }","duration":"234.280115ms","start":"2026-09-01T07:53:05.168402Z","end":"2026-09-01T07:53:05.402683Z","steps":["trace[1667787785] 'agreement among raft nodes before linearized reading' (duration: 234.110741ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T07:53:05.517389Z","caller":"traceutil/trace.go:171","msg":"trace[1136891179] linearizableReadLoop","detail":"{readStateIndex:17817; appliedIndex:17816; }","duration":"102.044398ms","start":"2026-09-01T07:53:05.415315Z","end":"2026-09-01T07:53:05.51736Z","steps":["trace[1136891179] 'read index received' (duration: 48.782277ms)","trace[1136891179] 'applied index is now lower than readState.Index' (duration: 53.260881ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T07:53:05.517469Z","caller":"traceutil/trace.go:171","msg":"trace[233805269] transaction","detail":"{read_only:false; response_revision:17219; number_of_response:1; }","duration":"102.957736ms","start":"2026-09-01T07:53:05.414477Z","end":"2026-09-01T07:53:05.517434Z","steps":["trace[233805269] 'process raft request' (duration: 49.559533ms)","trace[233805269] 'compare' (duration: 53.152708ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T07:53:05.518254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.920706ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:83 size:804337"} {"level":"info","ts":"2026-09-01T07:53:05.518333Z","caller":"traceutil/trace.go:171","msg":"trace[1305211126] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:83; response_revision:17219; }","duration":"103.048389ms","start":"2026-09-01T07:53:05.415268Z","end":"2026-09-01T07:53:05.518316Z","steps":["trace[1305211126] 'agreement among raft nodes before linearized reading' (duration: 102.18218ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T07:53:06.496143Z","caller":"traceutil/trace.go:171","msg":"trace[415185299] transaction","detail":"{read_only:false; response_revision:17225; number_of_response:1; }","duration":"118.722491ms","start":"2026-09-01T07:53:06.377391Z","end":"2026-09-01T07:53:06.496114Z","steps":["trace[415185299] 'process raft request' (duration: 118.566297ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T07:53:08.982968Z","caller":"traceutil/trace.go:171","msg":"trace[1736712583] transaction","detail":"{read_only:false; response_revision:17244; number_of_response:1; }","duration":"100.982624ms","start":"2026-09-01T07:53:08.881921Z","end":"2026-09-01T07:53:08.982903Z","steps":["trace[1736712583] 'process raft request' (duration: 100.76194ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T07:53:10.977906Z","caller":"traceutil/trace.go:171","msg":"trace[550291765] transaction","detail":"{read_only:false; response_revision:17258; number_of_response:1; }","duration":"102.336363ms","start":"2026-09-01T07:53:10.875497Z","end":"2026-09-01T07:53:10.977834Z","steps":["trace[550291765] 'process raft request' (duration: 101.975346ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T07:53:11.228742Z","caller":"traceutil/trace.go:171","msg":"trace[836428034] transaction","detail":"{read_only:false; response_revision:17270; number_of_response:1; }","duration":"106.00508ms","start":"2026-09-01T07:53:11.12271Z","end":"2026-09-01T07:53:11.228715Z","steps":["trace[836428034] 'process raft request' (duration: 99.345219ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T07:53:11.234129Z","caller":"traceutil/trace.go:171","msg":"trace[1617163759] linearizableReadLoop","detail":"{readStateIndex:17871; appliedIndex:17869; }","duration":"108.963324ms","start":"2026-09-01T07:53:11.125133Z","end":"2026-09-01T07:53:11.234097Z","steps":["trace[1617163759] 'read index received' (duration: 96.861527ms)","trace[1617163759] 'applied index is now lower than readState.Index' (duration: 12.100407ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T07:53:11.23421Z","caller":"traceutil/trace.go:171","msg":"trace[1118905718] transaction","detail":"{read_only:false; response_revision:17271; number_of_response:1; }","duration":"110.488075ms","start":"2026-09-01T07:53:11.123685Z","end":"2026-09-01T07:53:11.234173Z","steps":["trace[1118905718] 'process raft request' (duration: 110.21932ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T07:53:11.234451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.291691ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-09-01T07:53:11.234495Z","caller":"traceutil/trace.go:171","msg":"trace[426157842] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:17271; }","duration":"109.380994ms","start":"2026-09-01T07:53:11.125102Z","end":"2026-09-01T07:53:11.234483Z","steps":["trace[426157842] 'agreement among raft nodes before linearized reading' (duration: 109.157078ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T07:53:11.255191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.933497ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated\" ","response":"range_response_count:1 size:1344"} {"level":"info","ts":"2026-09-01T07:53:11.255252Z","caller":"traceutil/trace.go:171","msg":"trace[158297271] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated; range_end:; response_count:1; response_revision:17272; }","duration":"128.021929ms","start":"2026-09-01T07:53:11.127211Z","end":"2026-09-01T07:53:11.255233Z","steps":["trace[158297271] 'agreement among raft nodes before linearized reading' (duration: 127.856215ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T07:53:11.255343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.750028ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-01T07:53:11.255406Z","caller":"traceutil/trace.go:171","msg":"trace[303848556] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:17272; }","duration":"123.87739ms","start":"2026-09-01T07:53:11.131514Z","end":"2026-09-01T07:53:11.255391Z","steps":["trace[303848556] 'agreement among raft nodes before linearized reading' (duration: 123.746867ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T07:53:11.353807Z","caller":"traceutil/trace.go:171","msg":"trace[588716106] transaction","detail":"{read_only:false; response_revision:17273; number_of_response:1; }","duration":"115.549353ms","start":"2026-09-01T07:53:11.238079Z","end":"2026-09-01T07:53:11.353629Z","steps":["trace[588716106] 'process raft request' (duration: 94.994257ms)","trace[588716106] 'compare' (duration: 20.217529ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T07:53:11.353804Z","caller":"traceutil/trace.go:171","msg":"trace[1900610536] transaction","detail":"{read_only:false; response_revision:17274; number_of_response:1; }","duration":"115.656595ms","start":"2026-09-01T07:53:11.238117Z","end":"2026-09-01T07:53:11.353774Z","steps":["trace[1900610536] 'process raft request' (duration: 115.331268ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T07:53:11.690842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.570835ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:18"} {"level":"info","ts":"2026-09-01T07:53:11.690994Z","caller":"traceutil/trace.go:171","msg":"trace[1927286897] linearizableReadLoop","detail":"{readStateIndex:17879; appliedIndex:17878; }","duration":"277.580743ms","start":"2026-09-01T07:53:11.413388Z","end":"2026-09-01T07:53:11.690969Z","steps":["trace[1927286897] 'read index received' (duration: 87.822395ms)","trace[1927286897] 'applied index is now lower than readState.Index' (duration: 189.756668ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T07:53:11.691008Z","caller":"traceutil/trace.go:171","msg":"trace[1838435724] transaction","detail":"{read_only:false; response_revision:17279; number_of_response:1; }","duration":"279.192347ms","start":"2026-09-01T07:53:11.411786Z","end":"2026-09-01T07:53:11.690978Z","steps":["trace[1838435724] 'process raft request' (duration: 89.401268ms)","trace[1838435724] 'compare' (duration: 189.394271ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T07:53:11.691257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.858981ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config\" ","response":"range_response_count:1 size:709"} {"level":"info","ts":"2026-09-01T07:53:11.691297Z","caller":"traceutil/trace.go:171","msg":"trace[822943926] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config; range_end:; response_count:1; response_revision:17279; }","duration":"277.925212ms","start":"2026-09-01T07:53:11.413357Z","end":"2026-09-01T07:53:11.691283Z","steps":["trace[822943926] 'agreement among raft nodes before linearized reading' (duration: 277.714667ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T07:53:11.691351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.75293ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-9vg6j\" ","response":"range_response_count:1 size:22015"} {"level":"info","ts":"2026-09-01T07:53:11.691466Z","caller":"traceutil/trace.go:171","msg":"trace[1584051888] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-9vg6j; range_end:; response_count:1; response_revision:17279; }","duration":"215.905244ms","start":"2026-09-01T07:53:11.475538Z","end":"2026-09-01T07:53:11.691444Z","steps":["trace[1584051888] 'agreement among raft nodes before linearized reading' (duration: 215.610738ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T07:53:11.694634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.900683ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:57 size:2225409"} {"level":"info","ts":"2026-09-01T07:53:11.694725Z","caller":"traceutil/trace.go:171","msg":"trace[2144189866] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:57; response_revision:17279; }","duration":"263.999955ms","start":"2026-09-01T07:53:11.430703Z","end":"2026-09-01T07:53:11.694703Z","steps":["trace[2144189866] 'agreement among raft nodes before linearized reading' (duration: 260.397159ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T07:53:12.050089Z","caller":"traceutil/trace.go:171","msg":"trace[28952029] linearizableReadLoop","detail":"{readStateIndex:17880; appliedIndex:17879; }","duration":"352.500464ms","start":"2026-09-01T07:53:11.697562Z","end":"2026-09-01T07:53:12.050062Z","steps":["trace[28952029] 'read index received' (duration: 320.178038ms)","trace[28952029] 'applied index is now lower than readState.Index' (duration: 32.321026ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T07:53:12.050149Z","caller":"traceutil/trace.go:171","msg":"trace[861286420] transaction","detail":"{read_only:false; response_revision:17280; number_of_response:1; }","duration":"354.206711ms","start":"2026-09-01T07:53:11.695906Z","end":"2026-09-01T07:53:12.050112Z","steps":["trace[861286420] 'process raft request' (duration: 321.923846ms)","trace[861286420] 'compare' (duration: 31.979899ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T07:53:12.050314Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T07:53:11.695889Z","time spent":"354.354694ms","remote":"127.0.0.1:34316","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":734,"response count":0,"response size":42,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-01T07:53:12.050508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.382757ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1818"} {"level":"info","ts":"2026-09-01T07:53:12.050622Z","caller":"traceutil/trace.go:171","msg":"trace[2127219363] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:17280; }","duration":"315.54141ms","start":"2026-09-01T07:53:11.735032Z","end":"2026-09-01T07:53:12.050573Z","steps":["trace[2127219363] 'agreement among raft nodes before linearized reading' (duration: 315.228514ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T07:53:12.050672Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T07:53:11.735012Z","time spent":"315.648573ms","remote":"127.0.0.1:34328","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":1842,"request content":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" "} {"level":"warn","ts":"2026-09-01T07:53:12.050732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.147268ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" ","response":"range_response_count:92 size:76820"} {"level":"info","ts":"2026-09-01T07:53:12.05081Z","caller":"traceutil/trace.go:171","msg":"trace[1092595664] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:92; response_revision:17280; }","duration":"353.23211ms","start":"2026-09-01T07:53:11.697557Z","end":"2026-09-01T07:53:12.05079Z","steps":["trace[1092595664] 'agreement among raft nodes before linearized reading' (duration: 352.597016ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T07:53:12.050855Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T07:53:11.697547Z","time spent":"353.296152ms","remote":"127.0.0.1:34596","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":92,"response size":76844,"request content":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" "} {"level":"warn","ts":"2026-09-01T07:53:12.051159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.82601ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"warn","ts":"2026-09-01T07:53:12.051188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.923757ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/alertmanager-operated\" ","response":"range_response_count:1 size:1286"} {"level":"info","ts":"2026-09-01T07:53:12.051281Z","caller":"traceutil/trace.go:171","msg":"trace[833017356] range","detail":"{range_begin:/registry/services/specs/monitoring/alertmanager-operated; range_end:; response_count:1; response_revision:17280; }","duration":"348.06083ms","start":"2026-09-01T07:53:11.703195Z","end":"2026-09-01T07:53:12.051255Z","steps":["trace[833017356] 'agreement among raft nodes before linearized reading' (duration: 347.746284ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T07:53:12.051334Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T07:53:11.703181Z","time spent":"348.143812ms","remote":"127.0.0.1:34434","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":1310,"request content":"key:\"/registry/services/specs/monitoring/alertmanager-operated\" "} {"level":"info","ts":"2026-09-01T07:53:12.051228Z","caller":"traceutil/trace.go:171","msg":"trace[761087216] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:17280; }","duration":"148.947862ms","start":"2026-09-01T07:53:11.902264Z","end":"2026-09-01T07:53:12.051212Z","steps":["trace[761087216] 'agreement among raft nodes before linearized reading' (duration: 148.696667ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T07:53:12.051401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.777742ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:83 size:804237"} {"level":"info","ts":"2026-09-01T07:53:12.051446Z","caller":"traceutil/trace.go:171","msg":"trace[1516838880] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:83; response_revision:17280; }","duration":"353.859873ms","start":"2026-09-01T07:53:11.697574Z","end":"2026-09-01T07:53:12.051434Z","steps":["trace[1516838880] 'agreement among raft nodes before linearized reading' (duration: 352.637478ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T07:53:12.051491Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T07:53:11.697555Z","time spent":"353.924635ms","remote":"127.0.0.1:34420","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":83,"response size":804261,"request content":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" "} {"level":"warn","ts":"2026-09-01T07:53:12.051745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.09026ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:83 size:804237"} {"level":"info","ts":"2026-09-01T07:53:12.051799Z","caller":"traceutil/trace.go:171","msg":"trace[1246223076] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:83; response_revision:17280; }","duration":"347.187252ms","start":"2026-09-01T07:53:11.704598Z","end":"2026-09-01T07:53:12.051785Z","steps":["trace[1246223076] 'agreement among raft nodes before linearized reading' (duration: 346.286814ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T07:53:12.051836Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T07:53:11.704586Z","time spent":"347.239033ms","remote":"127.0.0.1:34420","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":83,"response size":804261,"request content":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" "} {"level":"info","ts":"2026-09-01T07:53:12.351463Z","caller":"traceutil/trace.go:171","msg":"trace[618692772] linearizableReadLoop","detail":"{readStateIndex:17884; appliedIndex:17883; }","duration":"128.700333ms","start":"2026-09-01T07:53:12.222741Z","end":"2026-09-01T07:53:12.351441Z","steps":["trace[618692772] 'read index received' (duration: 120.194062ms)","trace[618692772] 'applied index is now lower than readState.Index' (duration: 8.505071ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T07:53:12.351577Z","caller":"traceutil/trace.go:171","msg":"trace[1107428880] transaction","detail":"{read_only:false; response_revision:17284; number_of_response:1; }","duration":"149.385342ms","start":"2026-09-01T07:53:12.202151Z","end":"2026-09-01T07:53:12.351537Z","steps":["trace[1107428880] 'process raft request' (duration: 140.751269ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T07:53:12.351783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.465807ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0\" ","response":"range_response_count:1 size:651"} {"level":"info","ts":"2026-09-01T07:53:12.351845Z","caller":"traceutil/trace.go:171","msg":"trace[1299888703] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0; range_end:; response_count:1; response_revision:17284; }","duration":"152.562799ms","start":"2026-09-01T07:53:12.199266Z","end":"2026-09-01T07:53:12.351829Z","steps":["trace[1299888703] 'agreement among raft nodes before linearized reading' (duration: 152.349685ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T07:53:12.355296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.030508ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3685"} {"level":"info","ts":"2026-09-01T07:53:12.355376Z","caller":"traceutil/trace.go:171","msg":"trace[180330294] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:17285; }","duration":"127.169931ms","start":"2026-09-01T07:53:12.228186Z","end":"2026-09-01T07:53:12.355355Z","steps":["trace[180330294] 'agreement among raft nodes before linearized reading' (duration: 126.892435ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T07:53:12.635112Z","caller":"traceutil/trace.go:171","msg":"trace[2013645700] transaction","detail":"{read_only:false; response_revision:17293; number_of_response:1; }","duration":"145.434958ms","start":"2026-09-01T07:53:12.489653Z","end":"2026-09-01T07:53:12.635088Z","steps":["trace[2013645700] 'process raft request' (duration: 99.028232ms)","trace[2013645700] 'compare' (duration: 45.793392ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T07:53:12.635225Z","caller":"traceutil/trace.go:171","msg":"trace[452627680] transaction","detail":"{read_only:false; response_revision:17295; number_of_response:1; }","duration":"143.443636ms","start":"2026-09-01T07:53:12.491759Z","end":"2026-09-01T07:53:12.635202Z","steps":["trace[452627680] 'process raft request' (duration: 143.250291ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T07:53:12.635378Z","caller":"traceutil/trace.go:171","msg":"trace[1355007916] transaction","detail":"{read_only:false; response_revision:17294; number_of_response:1; }","duration":"145.55006ms","start":"2026-09-01T07:53:12.489774Z","end":"2026-09-01T07:53:12.635324Z","steps":["trace[1355007916] 'process raft request' (duration: 145.12347ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T07:53:12.635546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.285949ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-1\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-01T07:53:12.635669Z","caller":"traceutil/trace.go:171","msg":"trace[990670896] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-1; range_end:; response_count:0; response_revision:17295; }","duration":"100.510394ms","start":"2026-09-01T07:53:12.535134Z","end":"2026-09-01T07:53:12.635645Z","steps":["trace[990670896] 'agreement among raft nodes before linearized reading' (duration: 100.200568ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T07:53:12.667112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.489489ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-neutron\" ","response":"range_response_count:1 size:3294"} {"level":"warn","ts":"2026-09-01T07:53:12.667138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.727576ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config\" ","response":"range_response_count:1 size:709"} {"level":"info","ts":"2026-09-01T07:53:12.667201Z","caller":"traceutil/trace.go:171","msg":"trace[770057453] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-neutron; range_end:; response_count:1; response_revision:17296; }","duration":"129.607532ms","start":"2026-09-01T07:53:12.53757Z","end":"2026-09-01T07:53:12.667178Z","steps":["trace[770057453] 'agreement among raft nodes before linearized reading' (duration: 129.332326ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T07:53:12.667226Z","caller":"traceutil/trace.go:171","msg":"trace[1308956064] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config; range_end:; response_count:1; response_revision:17296; }","duration":"130.874069ms","start":"2026-09-01T07:53:12.536328Z","end":"2026-09-01T07:53:12.667202Z","steps":["trace[1308956064] 'agreement among raft nodes before linearized reading' (duration: 130.616494ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T07:53:12.899584Z","caller":"traceutil/trace.go:171","msg":"trace[467024748] transaction","detail":"{read_only:false; response_revision:17303; number_of_response:1; }","duration":"119.58886ms","start":"2026-09-01T07:53:12.779935Z","end":"2026-09-01T07:53:12.899524Z","steps":["trace[467024748] 'process raft request' (duration: 93.205399ms)","trace[467024748] 'compare' (duration: 25.604445ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T07:53:12.900886Z","caller":"traceutil/trace.go:171","msg":"trace[1371054460] transaction","detail":"{read_only:false; response_revision:17304; number_of_response:1; }","duration":"118.720111ms","start":"2026-09-01T07:53:12.782117Z","end":"2026-09-01T07:53:12.900838Z","steps":["trace[1371054460] 'process raft request' (duration: 117.211139ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T07:53:12.90107Z","caller":"traceutil/trace.go:171","msg":"trace[1231517342] transaction","detail":"{read_only:false; response_revision:17305; number_of_response:1; }","duration":"117.007363ms","start":"2026-09-01T07:53:12.784045Z","end":"2026-09-01T07:53:12.901053Z","steps":["trace[1231517342] 'process raft request' (duration: 116.690076ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T07:53:12.901056Z","caller":"traceutil/trace.go:171","msg":"trace[399945284] linearizableReadLoop","detail":"{readStateIndex:17905; appliedIndex:17902; }","duration":"107.029103ms","start":"2026-09-01T07:53:12.793998Z","end":"2026-09-01T07:53:12.901027Z","steps":["trace[399945284] 'read index received' (duration: 79.098659ms)","trace[399945284] 'applied index is now lower than readState.Index' (duration: 27.928983ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T07:53:12.901281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.712551ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/local-path-storage/\" range_end:\"/registry/limitranges/local-path-storage0\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-09-01T07:53:12.901291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.483429ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:4727"} {"level":"info","ts":"2026-09-01T07:53:12.90135Z","caller":"traceutil/trace.go:171","msg":"trace[1015042078] range","detail":"{range_begin:/registry/limitranges/local-path-storage/; range_end:/registry/limitranges/local-path-storage0; response_count:0; response_revision:17305; }","duration":"118.810913ms","start":"2026-09-01T07:53:12.782516Z","end":"2026-09-01T07:53:12.901327Z","steps":["trace[1015042078] 'agreement among raft nodes before linearized reading' (duration: 118.6949ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T07:53:12.901346Z","caller":"traceutil/trace.go:171","msg":"trace[1197842149] range","detail":"{range_begin:/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:17305; }","duration":"112.564201ms","start":"2026-09-01T07:53:12.788766Z","end":"2026-09-01T07:53:12.90133Z","steps":["trace[1197842149] 'agreement among raft nodes before linearized reading' (duration: 112.431407ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T07:53:12.901484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.907606ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/prometheus-operated\" ","response":"range_response_count:1 size:994"} {"level":"info","ts":"2026-09-01T07:53:12.901528Z","caller":"traceutil/trace.go:171","msg":"trace[1198677308] range","detail":"{range_begin:/registry/services/specs/monitoring/prometheus-operated; range_end:; response_count:1; response_revision:17305; }","duration":"102.982217ms","start":"2026-09-01T07:53:12.798534Z","end":"2026-09-01T07:53:12.901516Z","steps":["trace[1198677308] 'agreement among raft nodes before linearized reading' (duration: 102.743812ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T07:53:13.141562Z","caller":"traceutil/trace.go:171","msg":"trace[1295219897] transaction","detail":"{read_only:false; response_revision:17308; number_of_response:1; }","duration":"161.180912ms","start":"2026-09-01T07:53:12.980358Z","end":"2026-09-01T07:53:13.141539Z","steps":["trace[1295219897] 'process raft request' (duration: 160.873156ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T07:53:13.141445Z","caller":"traceutil/trace.go:171","msg":"trace[1381770726] linearizableReadLoop","detail":"{readStateIndex:17908; appliedIndex:17907; }","duration":"147.713056ms","start":"2026-09-01T07:53:12.993702Z","end":"2026-09-01T07:53:13.141415Z","steps":["trace[1381770726] 'read index received' (duration: 147.478051ms)","trace[1381770726] 'applied index is now lower than readState.Index' (duration: 233.605µs)"],"step_count":2} {"level":"warn","ts":"2026-09-01T07:53:13.141833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.102683ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-7fdefe71-5847-4fba-9f26-ceaf4e1de854\" ","response":"range_response_count:1 size:2580"} {"level":"info","ts":"2026-09-01T07:53:13.141936Z","caller":"traceutil/trace.go:171","msg":"trace[1394598367] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-7fdefe71-5847-4fba-9f26-ceaf4e1de854; range_end:; response_count:1; response_revision:17308; }","duration":"163.226736ms","start":"2026-09-01T07:53:12.978668Z","end":"2026-09-01T07:53:13.141895Z","steps":["trace[1394598367] 'agreement among raft nodes before linearized reading' (duration: 162.97326ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T07:53:13.21885Z","caller":"traceutil/trace.go:171","msg":"trace[1523019742] transaction","detail":"{read_only:false; response_revision:17309; number_of_response:1; }","duration":"218.969509ms","start":"2026-09-01T07:53:12.999845Z","end":"2026-09-01T07:53:13.218814Z","steps":["trace[1523019742] 'process raft request' (duration: 168.236672ms)","trace[1523019742] 'compare' (duration: 50.39164ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T07:53:13.219035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.096964ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-neutron-server\" ","response":"range_response_count:1 size:9623"} {"level":"warn","ts":"2026-09-01T07:53:13.219315Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.056198ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/neutron-server\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-01T07:53:13.219376Z","caller":"traceutil/trace.go:171","msg":"trace[1950521578] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-neutron-server; range_end:; response_count:1; response_revision:17309; }","duration":"220.486632ms","start":"2026-09-01T07:53:12.998862Z","end":"2026-09-01T07:53:13.219349Z","steps":["trace[1950521578] 'agreement among raft nodes before linearized reading' (duration: 219.874389ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T07:53:13.219319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.480031ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-09-01T07:53:13.219499Z","caller":"traceutil/trace.go:171","msg":"trace[1966605536] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:17309; }","duration":"122.732736ms","start":"2026-09-01T07:53:13.096745Z","end":"2026-09-01T07:53:13.219478Z","steps":["trace[1966605536] 'agreement among raft nodes before linearized reading' (duration: 122.305867ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T07:53:13.219728Z","caller":"traceutil/trace.go:171","msg":"trace[541169626] range","detail":"{range_begin:/registry/services/endpoints/openstack/neutron-server; range_end:; response_count:0; response_revision:17309; }","duration":"192.16234ms","start":"2026-09-01T07:53:13.027204Z","end":"2026-09-01T07:53:13.219367Z","steps":["trace[541169626] 'agreement among raft nodes before linearized reading' (duration: 192.008117ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T07:53:13.442589Z","caller":"traceutil/trace.go:171","msg":"trace[1597246780] linearizableReadLoop","detail":"{readStateIndex:17914; appliedIndex:17913; }","duration":"100.485293ms","start":"2026-09-01T07:53:13.34208Z","end":"2026-09-01T07:53:13.442566Z","steps":["trace[1597246780] 'read index received' (duration: 100.240808ms)","trace[1597246780] 'applied index is now lower than readState.Index' (duration: 240.775µs)"],"step_count":2} {"level":"info","ts":"2026-09-01T07:53:13.442637Z","caller":"traceutil/trace.go:171","msg":"trace[957549534] transaction","detail":"{read_only:false; response_revision:17314; number_of_response:1; }","duration":"124.989354ms","start":"2026-09-01T07:53:13.31762Z","end":"2026-09-01T07:53:13.442609Z","steps":["trace[957549534] 'process raft request' (duration: 124.77533ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T07:53:13.442817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.725189ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-neutron-server\" ","response":"range_response_count:1 size:9623"} {"level":"info","ts":"2026-09-01T07:53:13.442861Z","caller":"traceutil/trace.go:171","msg":"trace[1647368918] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-neutron-server; range_end:; response_count:1; response_revision:17314; }","duration":"100.81882ms","start":"2026-09-01T07:53:13.342033Z","end":"2026-09-01T07:53:13.442852Z","steps":["trace[1647368918] 'agreement among raft nodes before linearized reading' (duration: 100.667777ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T07:53:13.747525Z","caller":"traceutil/trace.go:171","msg":"trace[1992220831] transaction","detail":"{read_only:false; response_revision:17320; number_of_response:1; }","duration":"109.636049ms","start":"2026-09-01T07:53:13.637855Z","end":"2026-09-01T07:53:13.747491Z","steps":["trace[1992220831] 'process raft request' (duration: 108.637917ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T07:56:22.783479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.58004ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/neutron-server\" ","response":"range_response_count:1 size:701"} {"level":"info","ts":"2026-09-01T07:56:22.783567Z","caller":"traceutil/trace.go:171","msg":"trace[1776305063] range","detail":"{range_begin:/registry/services/endpoints/openstack/neutron-server; range_end:; response_count:1; response_revision:18738; }","duration":"120.709624ms","start":"2026-09-01T07:56:22.662838Z","end":"2026-09-01T07:56:22.783548Z","steps":["trace[1776305063] 'range keys from in-memory index tree' (duration: 120.372196ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T07:56:29.997357Z","caller":"traceutil/trace.go:171","msg":"trace[1443177364] transaction","detail":"{read_only:false; response_revision:18785; number_of_response:1; }","duration":"199.684444ms","start":"2026-09-01T07:56:29.797641Z","end":"2026-09-01T07:56:29.997325Z","steps":["trace[1443177364] 'process raft request' (duration: 199.50506ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T07:56:30.066594Z","caller":"traceutil/trace.go:171","msg":"trace[1700710971] linearizableReadLoop","detail":"{readStateIndex:19431; appliedIndex:19429; }","duration":"198.071098ms","start":"2026-09-01T07:56:29.868492Z","end":"2026-09-01T07:56:30.066563Z","steps":["trace[1700710971] 'read index received' (duration: 128.718895ms)","trace[1700710971] 'applied index is now lower than readState.Index' (duration: 69.350983ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T07:56:30.066641Z","caller":"traceutil/trace.go:171","msg":"trace[952961187] transaction","detail":"{read_only:false; response_revision:18786; number_of_response:1; }","duration":"265.857299ms","start":"2026-09-01T07:56:29.80076Z","end":"2026-09-01T07:56:30.066618Z","steps":["trace[952961187] 'process raft request' (duration: 265.609354ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T07:56:30.066763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.243402ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-09-01T07:56:30.066806Z","caller":"traceutil/trace.go:171","msg":"trace[1412080755] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:18786; }","duration":"198.330373ms","start":"2026-09-01T07:56:29.868467Z","end":"2026-09-01T07:56:30.066797Z","steps":["trace[1412080755] 'agreement among raft nodes before linearized reading' (duration: 198.214971ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T07:57:12.248778Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"d232699cb6c87299","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-09-01T07:57:12.255997Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-09-01T07:57:12.25618Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-09-01T07:57:40.155708Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":16977} {"level":"info","ts":"2026-09-01T07:57:40.252845Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":16977,"took":"93.476237ms","hash":222185048,"current-db-size-bytes":56078336,"current-db-size":"56 MB","current-db-size-in-use-bytes":34283520,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-09-01T07:57:40.252955Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":222185048,"revision":16977,"compact-revision":14509} {"level":"info","ts":"2026-09-01T08:02:18.038254Z","caller":"traceutil/trace.go:171","msg":"trace[1042364342] linearizableReadLoop","detail":"{readStateIndex:22299; appliedIndex:22298; }","duration":"213.521137ms","start":"2026-09-01T08:02:17.82469Z","end":"2026-09-01T08:02:18.038211Z","steps":["trace[1042364342] 'read index received' (duration: 213.20541ms)","trace[1042364342] 'applied index is now lower than readState.Index' (duration: 313.877µs)"],"step_count":2} {"level":"info","ts":"2026-09-01T08:02:18.038333Z","caller":"traceutil/trace.go:171","msg":"trace[280738046] transaction","detail":"{read_only:false; response_revision:21564; number_of_response:1; }","duration":"252.031022ms","start":"2026-09-01T08:02:17.786255Z","end":"2026-09-01T08:02:18.038286Z","steps":["trace[280738046] 'process raft request' (duration: 251.657324ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T08:02:18.038624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.897685ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-09-01T08:02:18.038714Z","caller":"traceutil/trace.go:171","msg":"trace[725378283] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:21564; }","duration":"214.038108ms","start":"2026-09-01T08:02:17.824656Z","end":"2026-09-01T08:02:18.038694Z","steps":["trace[725378283] 'agreement among raft nodes before linearized reading' (duration: 213.731522ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T08:02:18.038702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.389463ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-09-01T08:02:18.038768Z","caller":"traceutil/trace.go:171","msg":"trace[110546168] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:21564; }","duration":"212.585538ms","start":"2026-09-01T08:02:17.826167Z","end":"2026-09-01T08:02:18.038752Z","steps":["trace[110546168] 'agreement among raft nodes before linearized reading' (duration: 212.269181ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T08:02:18.039101Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.150174ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-01T08:02:18.039879Z","caller":"traceutil/trace.go:171","msg":"trace[387380183] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:21564; }","duration":"193.381331ms","start":"2026-09-01T08:02:17.846473Z","end":"2026-09-01T08:02:18.039854Z","steps":["trace[387380183] 'agreement among raft nodes before linearized reading' (duration: 192.068862ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T08:02:34.451944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.099574ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-09-01T08:02:34.452053Z","caller":"traceutil/trace.go:171","msg":"trace[1236147703] transaction","detail":"{read_only:false; response_revision:21650; number_of_response:1; }","duration":"196.080799ms","start":"2026-09-01T08:02:34.255951Z","end":"2026-09-01T08:02:34.452032Z","steps":["trace[1236147703] 'process raft request' (duration: 56.794911ms)","trace[1236147703] 'compare' (duration: 138.843309ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T08:02:34.659657Z","caller":"traceutil/trace.go:171","msg":"trace[1279117745] transaction","detail":"{read_only:false; response_revision:21651; number_of_response:1; }","duration":"161.089511ms","start":"2026-09-01T08:02:34.498532Z","end":"2026-09-01T08:02:34.659622Z","steps":["trace[1279117745] 'process raft request' (duration: 129.075267ms)","trace[1279117745] 'compare' (duration: 31.877411ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T08:02:34.920689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.870198ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-09-01T08:02:34.920911Z","caller":"traceutil/trace.go:171","msg":"trace[1832912344] linearizableReadLoop","detail":"{readStateIndex:22392; appliedIndex:22390; }","duration":"410.841794ms","start":"2026-09-01T08:02:34.51005Z","end":"2026-09-01T08:02:34.920892Z","steps":["trace[1832912344] 'read index received' (duration: 117.573128ms)","trace[1832912344] 'applied index is now lower than readState.Index' (duration: 293.267266ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T08:02:34.920928Z","caller":"traceutil/trace.go:171","msg":"trace[1230303316] transaction","detail":"{read_only:false; response_revision:21652; number_of_response:1; }","duration":"414.642606ms","start":"2026-09-01T08:02:34.506249Z","end":"2026-09-01T08:02:34.920891Z","steps":["trace[1230303316] 'process raft request' (duration: 294.472512ms)","trace[1230303316] 'compare' (duration: 119.55976ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T08:02:34.92095Z","caller":"traceutil/trace.go:171","msg":"trace[1028832666] transaction","detail":"{read_only:false; response_revision:21653; number_of_response:1; }","duration":"366.671037ms","start":"2026-09-01T08:02:34.554258Z","end":"2026-09-01T08:02:34.920929Z","steps":["trace[1028832666] 'process raft request' (duration: 366.519263ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T08:02:34.921083Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T08:02:34.506226Z","time spent":"414.776299ms","remote":"127.0.0.1:34502","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-01T08:02:34.921138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"411.081709ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"info","ts":"2026-09-01T08:02:34.921178Z","caller":"traceutil/trace.go:171","msg":"trace[1059161928] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:21653; }","duration":"411.152561ms","start":"2026-09-01T08:02:34.510015Z","end":"2026-09-01T08:02:34.921168Z","steps":["trace[1059161928] 'agreement among raft nodes before linearized reading' (duration: 410.950496ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T08:02:34.921208Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T08:02:34.510003Z","time spent":"411.197471ms","remote":"127.0.0.1:34502","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":465,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-09-01T08:02:34.921515Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T08:02:34.554234Z","time spent":"366.82998ms","remote":"127.0.0.1:34502","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-01T08:02:34.934228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"381.474877ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-09-01T08:02:34.9343Z","caller":"traceutil/trace.go:171","msg":"trace[881344516] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:21654; }","duration":"381.558078ms","start":"2026-09-01T08:02:34.552724Z","end":"2026-09-01T08:02:34.934282Z","steps":["trace[881344516] 'agreement among raft nodes before linearized reading' (duration: 381.411925ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T08:02:34.934336Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T08:02:34.552678Z","time spent":"381.648751ms","remote":"127.0.0.1:34628","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":32,"request content":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true "} {"level":"warn","ts":"2026-09-01T08:02:34.934528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.666011ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12217"} {"level":"info","ts":"2026-09-01T08:02:34.934617Z","caller":"traceutil/trace.go:171","msg":"trace[681918975] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:21654; }","duration":"273.794764ms","start":"2026-09-01T08:02:34.660801Z","end":"2026-09-01T08:02:34.934596Z","steps":["trace[681918975] 'agreement among raft nodes before linearized reading' (duration: 273.505288ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T08:02:34.934675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"356.910385ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-09-01T08:02:34.934747Z","caller":"traceutil/trace.go:171","msg":"trace[1692367094] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:21654; }","duration":"357.023958ms","start":"2026-09-01T08:02:34.577707Z","end":"2026-09-01T08:02:34.93473Z","steps":["trace[1692367094] 'agreement among raft nodes before linearized reading' (duration: 356.830934ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T08:02:34.93479Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T08:02:34.577689Z","time spent":"357.092499ms","remote":"127.0.0.1:34502","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":519,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-09-01T08:02:35.08637Z","caller":"traceutil/trace.go:171","msg":"trace[270353733] linearizableReadLoop","detail":"{readStateIndex:22395; appliedIndex:22394; }","duration":"148.62026ms","start":"2026-09-01T08:02:34.937722Z","end":"2026-09-01T08:02:35.086342Z","steps":["trace[270353733] 'read index received' (duration: 139.37089ms)","trace[270353733] 'applied index is now lower than readState.Index' (duration: 9.24786ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T08:02:35.086635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.877957ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12217"} {"level":"info","ts":"2026-09-01T08:02:35.086853Z","caller":"traceutil/trace.go:171","msg":"trace[1585800234] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:21655; }","duration":"149.157562ms","start":"2026-09-01T08:02:34.937685Z","end":"2026-09-01T08:02:35.086842Z","steps":["trace[1585800234] 'agreement among raft nodes before linearized reading' (duration: 148.767714ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T08:02:35.087021Z","caller":"traceutil/trace.go:171","msg":"trace[381567526] transaction","detail":"{read_only:false; response_revision:21656; number_of_response:1; }","duration":"148.452577ms","start":"2026-09-01T08:02:34.938544Z","end":"2026-09-01T08:02:35.086996Z","steps":["trace[381567526] 'process raft request' (duration: 148.001808ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T08:02:35.087456Z","caller":"traceutil/trace.go:171","msg":"trace[1631415390] transaction","detail":"{read_only:false; response_revision:21655; number_of_response:1; }","duration":"160.189201ms","start":"2026-09-01T08:02:34.926227Z","end":"2026-09-01T08:02:35.086416Z","steps":["trace[1631415390] 'process raft request' (duration: 150.858658ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T08:02:40.163461Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19602} {"level":"info","ts":"2026-09-01T08:02:40.305284Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19602,"took":"138.019943ms","hash":4001741584,"current-db-size-bytes":56078336,"current-db-size":"56 MB","current-db-size-in-use-bytes":30302208,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-09-01T08:02:40.305345Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4001741584,"revision":19602,"compact-revision":16977} {"level":"info","ts":"2026-09-01T08:06:36.461423Z","caller":"traceutil/trace.go:171","msg":"trace[1483384695] linearizableReadLoop","detail":"{readStateIndex:24997; appliedIndex:24996; }","duration":"136.019868ms","start":"2026-09-01T08:06:36.325369Z","end":"2026-09-01T08:06:36.461389Z","steps":["trace[1483384695] 'read index received' (duration: 135.754603ms)","trace[1483384695] 'applied index is now lower than readState.Index' (duration: 263.435µs)"],"step_count":2} {"level":"info","ts":"2026-09-01T08:06:36.461488Z","caller":"traceutil/trace.go:171","msg":"trace[1443978026] transaction","detail":"{read_only:false; response_revision:24183; number_of_response:1; }","duration":"188.180439ms","start":"2026-09-01T08:06:36.273263Z","end":"2026-09-01T08:06:36.461443Z","steps":["trace[1443978026] 'process raft request' (duration: 187.870242ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T08:06:36.461742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.342435ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"info","ts":"2026-09-01T08:06:36.461802Z","caller":"traceutil/trace.go:171","msg":"trace[2090311823] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24183; }","duration":"136.480708ms","start":"2026-09-01T08:06:36.325296Z","end":"2026-09-01T08:06:36.461776Z","steps":["trace[2090311823] 'agreement among raft nodes before linearized reading' (duration: 136.258003ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T08:06:36.474683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.622505ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclients/\" range_end:\"/registry/ceph.rook.io/cephclients0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-01T08:06:36.474792Z","caller":"traceutil/trace.go:171","msg":"trace[1458716548] range","detail":"{range_begin:/registry/ceph.rook.io/cephclients/; range_end:/registry/ceph.rook.io/cephclients0; response_count:0; response_revision:24184; }","duration":"109.780228ms","start":"2026-09-01T08:06:36.364974Z","end":"2026-09-01T08:06:36.474754Z","steps":["trace[1458716548] 'agreement among raft nodes before linearized reading' (duration: 109.527843ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T08:06:36.474788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.312398ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-09-01T08:06:36.474874Z","caller":"traceutil/trace.go:171","msg":"trace[831805563] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24184; }","duration":"147.435532ms","start":"2026-09-01T08:06:36.327421Z","end":"2026-09-01T08:06:36.474857Z","steps":["trace[831805563] 'agreement among raft nodes before linearized reading' (duration: 147.124485ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T08:07:40.170249Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":21679} {"level":"info","ts":"2026-09-01T08:07:40.281362Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":21679,"took":"107.193954ms","hash":1661889660,"current-db-size-bytes":56078336,"current-db-size":"56 MB","current-db-size-in-use-bytes":42872832,"current-db-size-in-use":"43 MB"} {"level":"info","ts":"2026-09-01T08:07:40.281425Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1661889660,"revision":21679,"compact-revision":19602} {"level":"info","ts":"2026-09-01T08:12:40.177808Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":24801} {"level":"info","ts":"2026-09-01T08:12:40.342827Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":24801,"took":"158.267978ms","hash":1155429222,"current-db-size-bytes":56078336,"current-db-size":"56 MB","current-db-size-in-use-bytes":31449088,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-09-01T08:12:40.342978Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1155429222,"revision":24801,"compact-revision":21679} {"level":"info","ts":"2026-09-01T08:13:11.265385Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-0000000000006e9e.wal"} {"level":"info","ts":"2026-09-01T08:16:51.942066Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"d232699cb6c87299","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-09-01T08:16:51.951717Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003} {"level":"info","ts":"2026-09-01T08:16:51.951889Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003}