{"level":"warn","ts":"2026-04-20T08:11:51.261322Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-20T08:11:51.261431Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.5:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.5:2380","--initial-cluster=instance=https://199.19.213.5:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.5:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.5: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-04-20T08:11:51.261504Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-20T08:11:51.261513Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.5:2380"]} {"level":"info","ts":"2026-04-20T08:11:51.261531Z","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-04-20T08:11:51.262205Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.5:2379"]} {"level":"info","ts":"2026-04-20T08:11:51.262283Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.5:2380"],"listen-peer-urls":["https://199.19.213.5:2380"],"advertise-client-urls":["https://199.19.213.5:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.5:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.5: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-04-20T08:11:51.266083Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.573466ms"} {"level":"info","ts":"2026-04-20T08:11:51.272797Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"dcb0af7a3afe1d6d","cluster-id":"4564295d4e5c9a3e"} {"level":"info","ts":"2026-04-20T08:11:51.272903Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dcb0af7a3afe1d6d switched to configuration voters=()"} {"level":"info","ts":"2026-04-20T08:11:51.272936Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dcb0af7a3afe1d6d became follower at term 0"} {"level":"info","ts":"2026-04-20T08:11:51.272957Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft dcb0af7a3afe1d6d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-20T08:11:51.27297Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dcb0af7a3afe1d6d became follower at term 1"} {"level":"info","ts":"2026-04-20T08:11:51.27303Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dcb0af7a3afe1d6d switched to configuration voters=(15902403223755824493)"} {"level":"warn","ts":"2026-04-20T08:11:51.278729Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-20T08:11:51.28025Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-20T08:11:51.281615Z","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-04-20T08:11:51.284032Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"dcb0af7a3afe1d6d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-20T08:11:51.284337Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"dcb0af7a3afe1d6d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-20T08:11:51.284404Z","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-04-20T08:11:51.284685Z","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-04-20T08:11:51.284732Z","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-04-20T08:11:51.286769Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dcb0af7a3afe1d6d switched to configuration voters=(15902403223755824493)"} {"level":"info","ts":"2026-04-20T08:11:51.288091Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"4564295d4e5c9a3e","local-member-id":"dcb0af7a3afe1d6d","added-peer-id":"dcb0af7a3afe1d6d","added-peer-peer-urls":["https://199.19.213.5:2380"]} {"level":"info","ts":"2026-04-20T08:11:51.290028Z","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-04-20T08:11:51.290226Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.5:2380"} {"level":"info","ts":"2026-04-20T08:11:51.290316Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.5:2380"} {"level":"info","ts":"2026-04-20T08:11:51.29051Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"dcb0af7a3afe1d6d","initial-advertise-peer-urls":["https://199.19.213.5:2380"],"listen-peer-urls":["https://199.19.213.5:2380"],"advertise-client-urls":["https://199.19.213.5:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.5:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-20T08:11:51.290628Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-20T08:11:52.273617Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dcb0af7a3afe1d6d is starting a new election at term 1"} {"level":"info","ts":"2026-04-20T08:11:52.273695Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dcb0af7a3afe1d6d became pre-candidate at term 1"} {"level":"info","ts":"2026-04-20T08:11:52.273757Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dcb0af7a3afe1d6d received MsgPreVoteResp from dcb0af7a3afe1d6d at term 1"} {"level":"info","ts":"2026-04-20T08:11:52.273785Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dcb0af7a3afe1d6d became candidate at term 2"} {"level":"info","ts":"2026-04-20T08:11:52.273808Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dcb0af7a3afe1d6d received MsgVoteResp from dcb0af7a3afe1d6d at term 2"} {"level":"info","ts":"2026-04-20T08:11:52.27383Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dcb0af7a3afe1d6d became leader at term 2"} {"level":"info","ts":"2026-04-20T08:11:52.273854Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: dcb0af7a3afe1d6d elected leader dcb0af7a3afe1d6d at term 2"} {"level":"info","ts":"2026-04-20T08:11:52.275275Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"dcb0af7a3afe1d6d","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.5:2379]}","request-path":"/0/members/dcb0af7a3afe1d6d/attributes","cluster-id":"4564295d4e5c9a3e","publish-timeout":"7s"} {"level":"info","ts":"2026-04-20T08:11:52.275394Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T08:11:52.27539Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-20T08:11:52.275551Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-20T08:11:52.275762Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-20T08:11:52.275828Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-20T08:11:52.276293Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"4564295d4e5c9a3e","local-member-id":"dcb0af7a3afe1d6d","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T08:11:52.27639Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T08:11:52.27646Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T08:11:52.279055Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.5:2379"} {"level":"info","ts":"2026-04-20T08:11:52.279124Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-20T08:11:54.58131Z","caller":"traceutil/trace.go:171","msg":"trace[233590837] transaction","detail":"{read_only:false; response_revision:110; number_of_response:1; }","duration":"115.864163ms","start":"2026-04-20T08:11:54.465407Z","end":"2026-04-20T08:11:54.581271Z","steps":["trace[233590837] 'process raft request' (duration: 115.649078ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:12:11.025297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.076626ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-20T08:12:29.584184Z","caller":"traceutil/trace.go:171","msg":"trace[1271162022] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"146.21756ms","start":"2026-04-20T08:12:29.437927Z","end":"2026-04-20T08:12:29.584144Z","steps":["trace[1271162022] 'process raft request' (duration: 137.924488ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:12:29.792139Z","caller":"traceutil/trace.go:171","msg":"trace[1672246576] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"140.578504ms","start":"2026-04-20T08:12:29.651512Z","end":"2026-04-20T08:12:29.79209Z","steps":["trace[1672246576] 'process raft request' (duration: 140.39378ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:12:30.465541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.725772ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T08:12:30.465775Z","caller":"traceutil/trace.go:171","msg":"trace[1391401036] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"578.446037ms","start":"2026-04-20T08:12:29.887275Z","end":"2026-04-20T08:12:30.465721Z","steps":["trace[1391401036] 'process raft request' (duration: 316.033638ms)","trace[1391401036] 'compare' (duration: 261.568159ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T08:12:30.465954Z","caller":"traceutil/trace.go:171","msg":"trace[608842265] linearizableReadLoop","detail":"{readStateIndex:644; appliedIndex:643; }","duration":"530.328982ms","start":"2026-04-20T08:12:29.935524Z","end":"2026-04-20T08:12:30.465853Z","steps":["trace[608842265] 'read index received' (duration: 267.709838ms)","trace[608842265] 'applied index is now lower than readState.Index' (duration: 262.611974ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T08:12:30.465998Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:12:29.887253Z","time spent":"578.629781ms","remote":"127.0.0.1:33218","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T08:12:30.466059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"530.468085ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T08:12:30.466169Z","caller":"traceutil/trace.go:171","msg":"trace[65208263] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:625; }","duration":"530.68384ms","start":"2026-04-20T08:12:29.935459Z","end":"2026-04-20T08:12:30.466143Z","steps":["trace[65208263] 'agreement among raft nodes before linearized reading' (duration: 530.453415ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:12:30.466217Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:12:29.935428Z","time spent":"530.780543ms","remote":"127.0.0.1:32966","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-20T08:12:30.466709Z","caller":"traceutil/trace.go:171","msg":"trace[205267879] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"254.730551ms","start":"2026-04-20T08:12:30.211947Z","end":"2026-04-20T08:12:30.466677Z","steps":["trace[205267879] 'process raft request' (duration: 253.989363ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:12:30.46679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"497.286684ms","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-04-20T08:12:30.466852Z","caller":"traceutil/trace.go:171","msg":"trace[1259020289] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:626; }","duration":"497.400918ms","start":"2026-04-20T08:12:29.969431Z","end":"2026-04-20T08:12:30.466832Z","steps":["trace[1259020289] 'agreement among raft nodes before linearized reading' (duration: 497.216413ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:12:30.466897Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:12:29.969403Z","time spent":"497.484229ms","remote":"127.0.0.1:33218","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-20T08:12:30.466931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.881796ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-04-20T08:12:30.466989Z","caller":"traceutil/trace.go:171","msg":"trace[740456904] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:626; }","duration":"200.936408ms","start":"2026-04-20T08:12:30.266035Z","end":"2026-04-20T08:12:30.466972Z","steps":["trace[740456904] 'agreement among raft nodes before linearized reading' (duration: 200.750683ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:12:31.559854Z","caller":"traceutil/trace.go:171","msg":"trace[809864482] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"108.91246ms","start":"2026-04-20T08:12:31.450903Z","end":"2026-04-20T08:12:31.559816Z","steps":["trace[809864482] 'process raft request' (duration: 107.064174ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:13:25.273806Z","caller":"traceutil/trace.go:171","msg":"trace[1417487774] transaction","detail":"{read_only:false; response_revision:1217; number_of_response:1; }","duration":"253.099843ms","start":"2026-04-20T08:13:25.020681Z","end":"2026-04-20T08:13:25.273781Z","steps":["trace[1417487774] 'process raft request' (duration: 252.926888ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:13:48.953061Z","caller":"traceutil/trace.go:171","msg":"trace[1425850919] transaction","detail":"{read_only:false; response_revision:1482; number_of_response:1; }","duration":"113.904456ms","start":"2026-04-20T08:13:48.839116Z","end":"2026-04-20T08:13:48.953021Z","steps":["trace[1425850919] 'process raft request' (duration: 113.64236ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:14:06.479366Z","caller":"traceutil/trace.go:171","msg":"trace[1469157098] transaction","detail":"{read_only:false; response_revision:1777; number_of_response:1; }","duration":"144.415786ms","start":"2026-04-20T08:14:06.33489Z","end":"2026-04-20T08:14:06.479305Z","steps":["trace[1469157098] 'process raft request' (duration: 144.078168ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:14:06.479421Z","caller":"traceutil/trace.go:171","msg":"trace[1886287123] transaction","detail":"{read_only:false; response_revision:1779; number_of_response:1; }","duration":"141.71583ms","start":"2026-04-20T08:14:06.337669Z","end":"2026-04-20T08:14:06.479385Z","steps":["trace[1886287123] 'process raft request' (duration: 141.600727ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:14:06.479438Z","caller":"traceutil/trace.go:171","msg":"trace[633487863] transaction","detail":"{read_only:false; response_revision:1778; number_of_response:1; }","duration":"142.54131ms","start":"2026-04-20T08:14:06.336848Z","end":"2026-04-20T08:14:06.479389Z","steps":["trace[633487863] 'process raft request' (duration: 142.338995ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:14:06.480264Z","caller":"traceutil/trace.go:171","msg":"trace[409055905] transaction","detail":"{read_only:false; response_revision:1780; number_of_response:1; }","duration":"142.308174ms","start":"2026-04-20T08:14:06.337931Z","end":"2026-04-20T08:14:06.480239Z","steps":["trace[409055905] 'process raft request' (duration: 141.406232ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:14:06.480506Z","caller":"traceutil/trace.go:171","msg":"trace[2085642782] transaction","detail":"{read_only:false; response_revision:1781; number_of_response:1; }","duration":"142.474588ms","start":"2026-04-20T08:14:06.337989Z","end":"2026-04-20T08:14:06.480464Z","steps":["trace[2085642782] 'process raft request' (duration: 142.109539ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:14:06.480576Z","caller":"traceutil/trace.go:171","msg":"trace[1824043597] transaction","detail":"{read_only:false; response_revision:1782; number_of_response:1; }","duration":"140.060588ms","start":"2026-04-20T08:14:06.340493Z","end":"2026-04-20T08:14:06.480554Z","steps":["trace[1824043597] 'process raft request' (duration: 139.71252ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:14:13.04216Z","caller":"traceutil/trace.go:171","msg":"trace[388584146] linearizableReadLoop","detail":"{readStateIndex:1950; appliedIndex:1949; }","duration":"171.942701ms","start":"2026-04-20T08:14:12.870126Z","end":"2026-04-20T08:14:13.042068Z","steps":["trace[388584146] 'read index received' (duration: 171.240334ms)","trace[388584146] 'applied index is now lower than readState.Index' (duration: 697.887µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T08:14:13.04242Z","caller":"traceutil/trace.go:171","msg":"trace[225283764] transaction","detail":"{read_only:false; response_revision:1883; number_of_response:1; }","duration":"300.452868ms","start":"2026-04-20T08:14:12.741932Z","end":"2026-04-20T08:14:13.042385Z","steps":["trace[225283764] 'process raft request' (duration: 299.405381ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:14:13.042378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.217849ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificaterequests/\" range_end:\"/registry/cert-manager.io/certificaterequests0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-20T08:14:13.042518Z","caller":"traceutil/trace.go:171","msg":"trace[2042305214] range","detail":"{range_begin:/registry/cert-manager.io/certificaterequests/; range_end:/registry/cert-manager.io/certificaterequests0; response_count:0; response_revision:1883; }","duration":"172.404034ms","start":"2026-04-20T08:14:12.870066Z","end":"2026-04-20T08:14:13.04247Z","steps":["trace[2042305214] 'agreement among raft nodes before linearized reading' (duration: 172.063394ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:14:13.04257Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:14:12.741915Z","time spent":"300.551041ms","remote":"127.0.0.1:33218","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":515,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T08:14:13.094629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.217991ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-1e0147a6-239b-4ac7-abf3-5f7601cd6afe\" ","response":"range_response_count:1 size:3625"} {"level":"warn","ts":"2026-04-20T08:14:13.094889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.774636ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T08:14:13.095008Z","caller":"traceutil/trace.go:171","msg":"trace[2007296020] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:1884; }","duration":"118.96125ms","start":"2026-04-20T08:14:12.976019Z","end":"2026-04-20T08:14:13.09498Z","steps":["trace[2007296020] 'agreement among raft nodes before linearized reading' (duration: 118.756845ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:14:13.094889Z","caller":"traceutil/trace.go:171","msg":"trace[2056569327] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-1e0147a6-239b-4ac7-abf3-5f7601cd6afe; range_end:; response_count:1; response_revision:1884; }","duration":"212.564629ms","start":"2026-04-20T08:14:12.882289Z","end":"2026-04-20T08:14:13.094854Z","steps":["trace[2056569327] 'agreement among raft nodes before linearized reading' (duration: 211.999105ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:14:13.332326Z","caller":"traceutil/trace.go:171","msg":"trace[1431103886] transaction","detail":"{read_only:false; response_revision:1888; number_of_response:1; }","duration":"153.832177ms","start":"2026-04-20T08:14:13.178464Z","end":"2026-04-20T08:14:13.332296Z","steps":["trace[1431103886] 'process raft request' (duration: 101.601435ms)","trace[1431103886] 'compare' (duration: 51.872304ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T08:14:13.332406Z","caller":"traceutil/trace.go:171","msg":"trace[1843516126] linearizableReadLoop","detail":"{readStateIndex:1955; appliedIndex:1954; }","duration":"120.241742ms","start":"2026-04-20T08:14:13.212089Z","end":"2026-04-20T08:14:13.332331Z","steps":["trace[1843516126] 'read index received' (duration: 67.898787ms)","trace[1843516126] 'applied index is now lower than readState.Index' (duration: 52.334885ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T08:14:13.332769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.652343ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-1e0147a6-239b-4ac7-abf3-5f7601cd6afe\" ","response":"range_response_count:1 size:3745"} {"level":"info","ts":"2026-04-20T08:14:13.332841Z","caller":"traceutil/trace.go:171","msg":"trace[1472455716] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-1e0147a6-239b-4ac7-abf3-5f7601cd6afe; range_end:; response_count:1; response_revision:1889; }","duration":"120.99059ms","start":"2026-04-20T08:14:13.211829Z","end":"2026-04-20T08:14:13.33282Z","steps":["trace[1472455716] 'agreement among raft nodes before linearized reading' (duration: 120.702343ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:14:57.404773Z","caller":"traceutil/trace.go:171","msg":"trace[173630798] linearizableReadLoop","detail":"{readStateIndex:2258; appliedIndex:2257; }","duration":"102.761393ms","start":"2026-04-20T08:14:57.301983Z","end":"2026-04-20T08:14:57.404745Z","steps":["trace[173630798] 'read index received' (duration: 102.671161ms)","trace[173630798] 'applied index is now lower than readState.Index' (duration: 88.312µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T08:14:57.404811Z","caller":"traceutil/trace.go:171","msg":"trace[456419756] transaction","detail":"{read_only:false; response_revision:2181; number_of_response:1; }","duration":"110.856473ms","start":"2026-04-20T08:14:57.293915Z","end":"2026-04-20T08:14:57.404772Z","steps":["trace[456419756] 'process raft request' (duration: 110.669629ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:14:57.405087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.082121ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12381"} {"level":"info","ts":"2026-04-20T08:14:57.405145Z","caller":"traceutil/trace.go:171","msg":"trace[1912855726] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2181; }","duration":"103.212565ms","start":"2026-04-20T08:14:57.301917Z","end":"2026-04-20T08:14:57.405129Z","steps":["trace[1912855726] 'agreement among raft nodes before linearized reading' (duration: 102.935118ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:14:58.402885Z","caller":"traceutil/trace.go:171","msg":"trace[658750166] linearizableReadLoop","detail":"{readStateIndex:2264; appliedIndex:2263; }","duration":"468.614408ms","start":"2026-04-20T08:14:57.934237Z","end":"2026-04-20T08:14:58.402852Z","steps":["trace[658750166] 'read index received' (duration: 468.253289ms)","trace[658750166] 'applied index is now lower than readState.Index' (duration: 359.819µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T08:14:58.402967Z","caller":"traceutil/trace.go:171","msg":"trace[1553520651] transaction","detail":"{read_only:false; response_revision:2187; number_of_response:1; }","duration":"499.092182ms","start":"2026-04-20T08:14:57.903826Z","end":"2026-04-20T08:14:58.402918Z","steps":["trace[1553520651] 'process raft request' (duration: 498.805985ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:14:58.403124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"468.855004ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T08:14:58.403179Z","caller":"traceutil/trace.go:171","msg":"trace[524163589] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2187; }","duration":"468.973557ms","start":"2026-04-20T08:14:57.934191Z","end":"2026-04-20T08:14:58.403165Z","steps":["trace[524163589] 'agreement among raft nodes before linearized reading' (duration: 468.850354ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:14:58.403183Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:14:57.9038Z","time spent":"499.271716ms","remote":"127.0.0.1:33218","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T08:14:58.403223Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:14:57.934172Z","time spent":"469.040338ms","remote":"127.0.0.1:32966","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-20T08:14:58.403324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.696244ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:529"} {"level":"info","ts":"2026-04-20T08:14:58.403438Z","caller":"traceutil/trace.go:171","msg":"trace[1234134146] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:2187; }","duration":"330.880188ms","start":"2026-04-20T08:14:58.072534Z","end":"2026-04-20T08:14:58.403414Z","steps":["trace[1234134146] 'agreement among raft nodes before linearized reading' (duration: 330.575001ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:14:58.403487Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:14:58.072509Z","time spent":"330.96928ms","remote":"127.0.0.1:33218","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":552,"request content":"key:\"/registry/leases/cert-manager/cert-manager-controller\" "} {"level":"info","ts":"2026-04-20T08:15:03.548353Z","caller":"traceutil/trace.go:171","msg":"trace[1020956428] transaction","detail":"{read_only:false; response_revision:2214; number_of_response:1; }","duration":"120.985594ms","start":"2026-04-20T08:15:03.42734Z","end":"2026-04-20T08:15:03.548326Z","steps":["trace[1020956428] 'process raft request' (duration: 120.711007ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:16:23.4239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.96462ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-20T08:16:23.424021Z","caller":"traceutil/trace.go:171","msg":"trace[1544269269] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2842; }","duration":"204.151846ms","start":"2026-04-20T08:16:23.219842Z","end":"2026-04-20T08:16:23.423994Z","steps":["trace[1544269269] 'range keys from in-memory index tree' (duration: 203.711063ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:20:27.210861Z","caller":"traceutil/trace.go:171","msg":"trace[1312170222] linearizableReadLoop","detail":"{readStateIndex:5138; appliedIndex:5137; }","duration":"103.291583ms","start":"2026-04-20T08:20:27.107538Z","end":"2026-04-20T08:20:27.21083Z","steps":["trace[1312170222] 'read index received' (duration: 101.037208ms)","trace[1312170222] 'applied index is now lower than readState.Index' (duration: 2.251845ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T08:20:27.211163Z","caller":"traceutil/trace.go:171","msg":"trace[393570768] transaction","detail":"{read_only:false; response_revision:4956; number_of_response:1; }","duration":"110.180656ms","start":"2026-04-20T08:20:27.100971Z","end":"2026-04-20T08:20:27.211152Z","steps":["trace[393570768] 'process raft request' (duration: 107.669445ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:20:27.211426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.88426ms","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:4847"} {"level":"info","ts":"2026-04-20T08:20:27.211458Z","caller":"traceutil/trace.go:171","msg":"trace[872137618] range","detail":"{range_begin:/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:4956; }","duration":"103.979213ms","start":"2026-04-20T08:20:27.10747Z","end":"2026-04-20T08:20:27.211449Z","steps":["trace[872137618] 'agreement among raft nodes before linearized reading' (duration: 103.844659ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:20:28.116259Z","caller":"traceutil/trace.go:171","msg":"trace[1708099885] transaction","detail":"{read_only:false; response_revision:4965; number_of_response:1; }","duration":"178.464829ms","start":"2026-04-20T08:20:27.937755Z","end":"2026-04-20T08:20:28.11622Z","steps":["trace[1708099885] 'process raft request' (duration: 178.193981ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:20:28.116796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.847156ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:23 size:521799"} {"level":"info","ts":"2026-04-20T08:20:28.116891Z","caller":"traceutil/trace.go:171","msg":"trace[1279783460] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:23; response_revision:4965; }","duration":"133.96637ms","start":"2026-04-20T08:20:27.982905Z","end":"2026-04-20T08:20:28.116872Z","steps":["trace[1279783460] 'agreement among raft nodes before linearized reading' (duration: 133.370095ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:20:31.518537Z","caller":"traceutil/trace.go:171","msg":"trace[1619250786] linearizableReadLoop","detail":"{readStateIndex:5271; appliedIndex:5270; }","duration":"101.413667ms","start":"2026-04-20T08:20:31.417085Z","end":"2026-04-20T08:20:31.518499Z","steps":["trace[1619250786] 'read index received' (duration: 101.136761ms)","trace[1619250786] 'applied index is now lower than readState.Index' (duration: 275.826µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T08:20:31.518635Z","caller":"traceutil/trace.go:171","msg":"trace[801233170] transaction","detail":"{read_only:false; response_revision:5086; number_of_response:1; }","duration":"127.545969ms","start":"2026-04-20T08:20:31.391056Z","end":"2026-04-20T08:20:31.518602Z","steps":["trace[801233170] 'process raft request' (duration: 127.241642ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:20:31.518868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.753396ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-20T08:20:31.518918Z","caller":"traceutil/trace.go:171","msg":"trace[378523621] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:5086; }","duration":"101.882809ms","start":"2026-04-20T08:20:31.417022Z","end":"2026-04-20T08:20:31.518905Z","steps":["trace[378523621] 'agreement among raft nodes before linearized reading' (duration: 101.657774ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:20:31.711737Z","caller":"traceutil/trace.go:171","msg":"trace[246947846] transaction","detail":"{read_only:false; response_revision:5088; number_of_response:1; }","duration":"187.639737ms","start":"2026-04-20T08:20:31.52407Z","end":"2026-04-20T08:20:31.71171Z","steps":["trace[246947846] 'process raft request' (duration: 187.560626ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:20:31.711799Z","caller":"traceutil/trace.go:171","msg":"trace[415083885] transaction","detail":"{read_only:false; response_revision:5087; number_of_response:1; }","duration":"187.688658ms","start":"2026-04-20T08:20:31.524054Z","end":"2026-04-20T08:20:31.711742Z","steps":["trace[415083885] 'process raft request' (duration: 182.051438ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:20:31.734537Z","caller":"traceutil/trace.go:171","msg":"trace[182889648] linearizableReadLoop","detail":"{readStateIndex:5274; appliedIndex:5271; }","duration":"194.622901ms","start":"2026-04-20T08:20:31.539897Z","end":"2026-04-20T08:20:31.734519Z","steps":["trace[182889648] 'read index received' (duration: 166.151741ms)","trace[182889648] 'applied index is now lower than readState.Index' (duration: 28.47017ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T08:20:31.734634Z","caller":"traceutil/trace.go:171","msg":"trace[1675165205] transaction","detail":"{read_only:false; response_revision:5089; number_of_response:1; }","duration":"210.481257ms","start":"2026-04-20T08:20:31.524146Z","end":"2026-04-20T08:20:31.734627Z","steps":["trace[1675165205] 'process raft request' (duration: 210.22169ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:20:31.735199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.298507ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-prl2h-tls\" ","response":"range_response_count:1 size:1965"} {"level":"info","ts":"2026-04-20T08:20:31.73523Z","caller":"traceutil/trace.go:171","msg":"trace[604363193] range","detail":"{range_begin:/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-prl2h-tls; range_end:; response_count:1; response_revision:5090; }","duration":"195.393299ms","start":"2026-04-20T08:20:31.539826Z","end":"2026-04-20T08:20:31.735219Z","steps":["trace[604363193] 'agreement among raft nodes before linearized reading' (duration: 195.169944ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:20:31.735518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.29584ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:24 size:719246"} {"level":"info","ts":"2026-04-20T08:20:31.735635Z","caller":"traceutil/trace.go:171","msg":"trace[157024630] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:24; response_revision:5090; }","duration":"100.441984ms","start":"2026-04-20T08:20:31.63517Z","end":"2026-04-20T08:20:31.735612Z","steps":["trace[157024630] 'agreement among raft nodes before linearized reading' (duration: 99.716165ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:20:32.076644Z","caller":"traceutil/trace.go:171","msg":"trace[1781412646] transaction","detail":"{read_only:false; response_revision:5091; number_of_response:1; }","duration":"104.499014ms","start":"2026-04-20T08:20:31.972115Z","end":"2026-04-20T08:20:32.076614Z","steps":["trace[1781412646] 'process raft request' (duration: 104.32112ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:20:36.774781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.00298ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T08:20:36.774873Z","caller":"traceutil/trace.go:171","msg":"trace[702777516] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:5208; }","duration":"130.135733ms","start":"2026-04-20T08:20:36.644718Z","end":"2026-04-20T08:20:36.774854Z","steps":["trace[702777516] 'count revisions from in-memory index tree' (duration: 129.922098ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:20:43.935903Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.244682ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-g6k6p\" ","response":"range_response_count:1 size:6516"} {"level":"info","ts":"2026-04-20T08:20:43.93598Z","caller":"traceutil/trace.go:171","msg":"trace[2050831797] range","detail":"{range_begin:/registry/pods/openstack/keepalived-g6k6p; range_end:; response_count:1; response_revision:5328; }","duration":"133.351024ms","start":"2026-04-20T08:20:43.80261Z","end":"2026-04-20T08:20:43.935961Z","steps":["trace[2050831797] 'range keys from in-memory index tree' (duration: 133.112578ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:20:43.936036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.138713ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"warn","ts":"2026-04-20T08:20:43.936046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.899231ms","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-04-20T08:20:43.936118Z","caller":"traceutil/trace.go:171","msg":"trace[1067405652] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5328; }","duration":"146.248325ms","start":"2026-04-20T08:20:43.789851Z","end":"2026-04-20T08:20:43.9361Z","steps":["trace[1067405652] 'range keys from in-memory index tree' (duration: 146.009179ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:20:43.936124Z","caller":"traceutil/trace.go:171","msg":"trace[7832253] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5328; }","duration":"149.092086ms","start":"2026-04-20T08:20:43.787016Z","end":"2026-04-20T08:20:43.936108Z","steps":["trace[7832253] 'range keys from in-memory index tree' (duration: 148.693317ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:20:43.936498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.890991ms","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-04-20T08:20:43.93662Z","caller":"traceutil/trace.go:171","msg":"trace[369195624] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5328; }","duration":"149.487946ms","start":"2026-04-20T08:20:43.787104Z","end":"2026-04-20T08:20:43.936592Z","steps":["trace[369195624] 'range keys from in-memory index tree' (duration: 148.636064ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:20:44.320584Z","caller":"traceutil/trace.go:171","msg":"trace[959353253] transaction","detail":"{read_only:false; response_revision:5332; number_of_response:1; }","duration":"218.895516ms","start":"2026-04-20T08:20:44.101657Z","end":"2026-04-20T08:20:44.320553Z","steps":["trace[959353253] 'process raft request' (duration: 218.64516ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:20:44.56314Z","caller":"traceutil/trace.go:171","msg":"trace[18119959] transaction","detail":"{read_only:false; response_revision:5333; number_of_response:1; }","duration":"372.781083ms","start":"2026-04-20T08:20:44.190322Z","end":"2026-04-20T08:20:44.563103Z","steps":["trace[18119959] 'process raft request' (duration: 372.514405ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:20:44.563397Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:20:44.190289Z","time spent":"372.967098ms","remote":"127.0.0.1:33218","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T08:20:44.573043Z","caller":"traceutil/trace.go:171","msg":"trace[1306947659] transaction","detail":"{read_only:false; response_revision:5334; number_of_response:1; }","duration":"246.183327ms","start":"2026-04-20T08:20:44.32683Z","end":"2026-04-20T08:20:44.573013Z","steps":["trace[1306947659] 'process raft request' (duration: 245.747826ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:20:44.573116Z","caller":"traceutil/trace.go:171","msg":"trace[152944970] transaction","detail":"{read_only:false; response_revision:5335; number_of_response:1; }","duration":"245.465758ms","start":"2026-04-20T08:20:44.327609Z","end":"2026-04-20T08:20:44.573075Z","steps":["trace[152944970] 'process raft request' (duration: 245.178511ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:20:44.573426Z","caller":"traceutil/trace.go:171","msg":"trace[470882800] transaction","detail":"{read_only:false; response_revision:5336; number_of_response:1; }","duration":"244.510505ms","start":"2026-04-20T08:20:44.328892Z","end":"2026-04-20T08:20:44.573403Z","steps":["trace[470882800] 'process raft request' (duration: 243.977531ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:20:44.573633Z","caller":"traceutil/trace.go:171","msg":"trace[50676557] transaction","detail":"{read_only:false; response_revision:5337; number_of_response:1; }","duration":"244.605207ms","start":"2026-04-20T08:20:44.329002Z","end":"2026-04-20T08:20:44.573607Z","steps":["trace[50676557] 'process raft request' (duration: 244.293349ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:20:44.573718Z","caller":"traceutil/trace.go:171","msg":"trace[281874537] linearizableReadLoop","detail":"{readStateIndex:5530; appliedIndex:5525; }","duration":"201.203605ms","start":"2026-04-20T08:20:44.372502Z","end":"2026-04-20T08:20:44.573705Z","steps":["trace[281874537] 'read index received' (duration: 190.388055ms)","trace[281874537] 'applied index is now lower than readState.Index' (duration: 10.81428ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T08:20:44.574067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.311268ms","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-04-20T08:20:44.574117Z","caller":"traceutil/trace.go:171","msg":"trace[498118863] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5338; }","duration":"130.432561ms","start":"2026-04-20T08:20:44.443671Z","end":"2026-04-20T08:20:44.574104Z","steps":["trace[498118863] 'agreement among raft nodes before linearized reading' (duration: 130.279417ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:20:44.574168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.631386ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T08:20:44.57431Z","caller":"traceutil/trace.go:171","msg":"trace[1737532833] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:5338; }","duration":"201.937295ms","start":"2026-04-20T08:20:44.372343Z","end":"2026-04-20T08:20:44.574281Z","steps":["trace[1737532833] 'agreement among raft nodes before linearized reading' (duration: 201.709068ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:20:44.574224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.686028ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-04-20T08:20:44.574506Z","caller":"traceutil/trace.go:171","msg":"trace[1534791583] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5338; }","duration":"129.019526ms","start":"2026-04-20T08:20:44.445469Z","end":"2026-04-20T08:20:44.574489Z","steps":["trace[1534791583] 'agreement among raft nodes before linearized reading' (duration: 128.610285ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:20:52.576673Z","caller":"traceutil/trace.go:171","msg":"trace[1501994635] transaction","detail":"{read_only:false; response_revision:5524; number_of_response:1; }","duration":"207.740738ms","start":"2026-04-20T08:20:52.368882Z","end":"2026-04-20T08:20:52.576623Z","steps":["trace[1501994635] 'process raft request' (duration: 172.052808ms)","trace[1501994635] 'compare' (duration: 35.244279ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T08:20:52.799483Z","caller":"traceutil/trace.go:171","msg":"trace[1942889227] transaction","detail":"{read_only:false; response_revision:5525; number_of_response:1; }","duration":"430.514142ms","start":"2026-04-20T08:20:52.368946Z","end":"2026-04-20T08:20:52.79946Z","steps":["trace[1942889227] 'process raft request' (duration: 338.5578ms)","trace[1942889227] 'compare' (duration: 91.804128ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T08:20:52.799625Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:20:52.36893Z","time spent":"430.619584ms","remote":"127.0.0.1:33242","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1616,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T08:20:52.799819Z","caller":"traceutil/trace.go:171","msg":"trace[461100609] transaction","detail":"{read_only:false; response_revision:5526; number_of_response:1; }","duration":"430.810799ms","start":"2026-04-20T08:20:52.368977Z","end":"2026-04-20T08:20:52.799788Z","steps":["trace[461100609] 'process raft request' (duration: 430.44546ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:20:52.799902Z","caller":"traceutil/trace.go:171","msg":"trace[1724587187] linearizableReadLoop","detail":"{readStateIndex:5723; appliedIndex:5720; }","duration":"370.802554ms","start":"2026-04-20T08:20:52.429053Z","end":"2026-04-20T08:20:52.799855Z","steps":["trace[1724587187] 'read index received' (duration: 111.89645ms)","trace[1724587187] 'applied index is now lower than readState.Index' (duration: 258.902124ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T08:20:52.799964Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:20:52.368946Z","time spent":"430.952003ms","remote":"127.0.0.1:33242","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1600,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T08:20:52.799946Z","caller":"traceutil/trace.go:171","msg":"trace[1280273315] transaction","detail":"{read_only:false; response_revision:5527; number_of_response:1; }","duration":"197.306729ms","start":"2026-04-20T08:20:52.60259Z","end":"2026-04-20T08:20:52.799896Z","steps":["trace[1280273315] 'process raft request' (duration: 197.128784ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:20:52.800145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"371.09903ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-855719f6-4afb-4730-a085-0754d8dbf377\" ","response":"range_response_count:1 size:3644"} {"level":"info","ts":"2026-04-20T08:20:52.800251Z","caller":"traceutil/trace.go:171","msg":"trace[2112562548] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-855719f6-4afb-4730-a085-0754d8dbf377; range_end:; response_count:1; response_revision:5527; }","duration":"371.273625ms","start":"2026-04-20T08:20:52.428955Z","end":"2026-04-20T08:20:52.800229Z","steps":["trace[2112562548] 'agreement among raft nodes before linearized reading' (duration: 371.004768ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:20:52.800309Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:20:52.428914Z","time spent":"371.381088ms","remote":"127.0.0.1:33144","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3667,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-855719f6-4afb-4730-a085-0754d8dbf377\" "} {"level":"warn","ts":"2026-04-20T08:20:52.813092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.736912ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-grafana.18a802e106ecf3dd\" ","response":"range_response_count:1 size:736"} {"level":"warn","ts":"2026-04-20T08:20:52.813125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.295664ms","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-04-20T08:20:52.813175Z","caller":"traceutil/trace.go:171","msg":"trace[1359034715] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-grafana.18a802e106ecf3dd; range_end:; response_count:1; response_revision:5528; }","duration":"230.924347ms","start":"2026-04-20T08:20:52.58223Z","end":"2026-04-20T08:20:52.813154Z","steps":["trace[1359034715] 'agreement among raft nodes before linearized reading' (duration: 230.67446ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:20:52.813203Z","caller":"traceutil/trace.go:171","msg":"trace[1870328768] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5528; }","duration":"186.402916ms","start":"2026-04-20T08:20:52.626772Z","end":"2026-04-20T08:20:52.813175Z","steps":["trace[1870328768] 'agreement among raft nodes before linearized reading' (duration: 186.231932ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:20:52.813106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.130701ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-04-20T08:20:52.813258Z","caller":"traceutil/trace.go:171","msg":"trace[1546474393] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5528; }","duration":"103.347746ms","start":"2026-04-20T08:20:52.709892Z","end":"2026-04-20T08:20:52.81324Z","steps":["trace[1546474393] 'agreement among raft nodes before linearized reading' (duration: 103.044357ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:20:52.979053Z","caller":"traceutil/trace.go:171","msg":"trace[467635256] transaction","detail":"{read_only:false; response_revision:5529; number_of_response:1; }","duration":"163.244209ms","start":"2026-04-20T08:20:52.815755Z","end":"2026-04-20T08:20:52.978999Z","steps":["trace[467635256] 'process raft request' (duration: 134.052671ms)","trace[467635256] 'compare' (duration: 28.880321ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T08:20:52.979267Z","caller":"traceutil/trace.go:171","msg":"trace[1547454417] transaction","detail":"{read_only:false; response_revision:5530; number_of_response:1; }","duration":"162.336687ms","start":"2026-04-20T08:20:52.816876Z","end":"2026-04-20T08:20:52.979213Z","steps":["trace[1547454417] 'process raft request' (duration: 162.133422ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:20:52.979475Z","caller":"traceutil/trace.go:171","msg":"trace[1484943042] transaction","detail":"{read_only:false; response_revision:5531; number_of_response:1; }","duration":"161.892756ms","start":"2026-04-20T08:20:52.81757Z","end":"2026-04-20T08:20:52.979463Z","steps":["trace[1484943042] 'process raft request' (duration: 161.542287ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:20:53.169691Z","caller":"traceutil/trace.go:171","msg":"trace[1449181976] transaction","detail":"{read_only:false; response_revision:5534; number_of_response:1; }","duration":"152.006059ms","start":"2026-04-20T08:20:53.017639Z","end":"2026-04-20T08:20:53.169645Z","steps":["trace[1449181976] 'process raft request' (duration: 151.892346ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:20:53.169696Z","caller":"traceutil/trace.go:171","msg":"trace[1777596538] transaction","detail":"{read_only:false; response_revision:5533; number_of_response:1; }","duration":"171.345252ms","start":"2026-04-20T08:20:52.998291Z","end":"2026-04-20T08:20:53.169636Z","steps":["trace[1777596538] 'process raft request' (duration: 169.831523ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:20:53.169756Z","caller":"traceutil/trace.go:171","msg":"trace[963823100] transaction","detail":"{read_only:false; response_revision:5535; number_of_response:1; }","duration":"143.409215ms","start":"2026-04-20T08:20:53.026287Z","end":"2026-04-20T08:20:53.169696Z","steps":["trace[963823100] 'process raft request' (duration: 143.293172ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:21:52.307029Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3003} {"level":"info","ts":"2026-04-20T08:21:52.388442Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3003,"took":"78.870218ms","hash":2373160940,"current-db-size-bytes":57032704,"current-db-size":"57 MB","current-db-size-in-use-bytes":31121408,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-04-20T08:21:52.388497Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2373160940,"revision":3003,"compact-revision":-1} {"level":"info","ts":"2026-04-20T08:26:52.313955Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6077} {"level":"info","ts":"2026-04-20T08:26:52.410277Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6077,"took":"93.631236ms","hash":156627524,"current-db-size-bytes":57032704,"current-db-size":"57 MB","current-db-size-in-use-bytes":23838720,"current-db-size-in-use":"24 MB"} {"level":"info","ts":"2026-04-20T08:26:52.41038Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":156627524,"revision":6077,"compact-revision":3003} {"level":"info","ts":"2026-04-20T08:26:52.8573Z","caller":"traceutil/trace.go:171","msg":"trace[546825975] transaction","detail":"{read_only:false; response_revision:8302; number_of_response:1; }","duration":"338.354152ms","start":"2026-04-20T08:26:52.518916Z","end":"2026-04-20T08:26:52.857271Z","steps":["trace[546825975] 'process raft request' (duration: 338.144497ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:26:52.857544Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:26:52.518888Z","time spent":"338.547428ms","remote":"127.0.0.1:33218","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T08:26:53.060764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.312303ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T08:26:53.061062Z","caller":"traceutil/trace.go:171","msg":"trace[953541832] linearizableReadLoop","detail":"{readStateIndex:8588; appliedIndex:8586; }","duration":"400.645383ms","start":"2026-04-20T08:26:52.660379Z","end":"2026-04-20T08:26:53.061025Z","steps":["trace[953541832] 'read index received' (duration: 196.785028ms)","trace[953541832] 'applied index is now lower than readState.Index' (duration: 203.858915ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T08:26:53.061214Z","caller":"traceutil/trace.go:171","msg":"trace[278962223] transaction","detail":"{read_only:false; response_revision:8303; number_of_response:1; }","duration":"467.431625ms","start":"2026-04-20T08:26:52.593764Z","end":"2026-04-20T08:26:53.061195Z","steps":["trace[278962223] 'process raft request' (duration: 342.536308ms)","trace[278962223] 'compare' (duration: 124.082697ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T08:26:53.061306Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:26:52.593729Z","time spent":"467.521248ms","remote":"127.0.0.1:33218","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T08:26:53.061618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.333948ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-04-20T08:26:53.061666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.143153ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T08:26:53.061743Z","caller":"traceutil/trace.go:171","msg":"trace[1742052387] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8304; }","duration":"127.253346ms","start":"2026-04-20T08:26:52.934466Z","end":"2026-04-20T08:26:53.06172Z","steps":["trace[1742052387] 'agreement among raft nodes before linearized reading' (duration: 127.117253ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:26:53.061735Z","caller":"traceutil/trace.go:171","msg":"trace[766474149] transaction","detail":"{read_only:false; response_revision:8304; number_of_response:1; }","duration":"211.805313ms","start":"2026-04-20T08:26:52.849882Z","end":"2026-04-20T08:26:53.061687Z","steps":["trace[766474149] 'process raft request' (duration: 211.026494ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:26:53.06174Z","caller":"traceutil/trace.go:171","msg":"trace[1437089678] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8304; }","duration":"234.523562ms","start":"2026-04-20T08:26:52.827184Z","end":"2026-04-20T08:26:53.061708Z","steps":["trace[1437089678] 'agreement among raft nodes before linearized reading' (duration: 234.185004ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:26:53.061866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.869975ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/barbican-api-84966475d-fpmp5\" ","response":"range_response_count:1 size:8464"} {"level":"info","ts":"2026-04-20T08:26:53.06192Z","caller":"traceutil/trace.go:171","msg":"trace[1939578979] range","detail":"{range_begin:/registry/pods/openstack/barbican-api-84966475d-fpmp5; range_end:; response_count:1; response_revision:8304; }","duration":"211.968667ms","start":"2026-04-20T08:26:52.849922Z","end":"2026-04-20T08:26:53.061891Z","steps":["trace[1939578979] 'agreement among raft nodes before linearized reading' (duration: 211.850005ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:26:53.06159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"401.174246ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-20T08:26:53.061888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.414558ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/scrapeconfigs/\" range_end:\"/registry/monitoring.coreos.com/scrapeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T08:26:53.062023Z","caller":"traceutil/trace.go:171","msg":"trace[1633442421] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:8304; }","duration":"401.68786ms","start":"2026-04-20T08:26:52.660305Z","end":"2026-04-20T08:26:53.061993Z","steps":["trace[1633442421] 'agreement among raft nodes before linearized reading' (duration: 401.028733ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:26:53.06205Z","caller":"traceutil/trace.go:171","msg":"trace[216385914] range","detail":"{range_begin:/registry/monitoring.coreos.com/scrapeconfigs/; range_end:/registry/monitoring.coreos.com/scrapeconfigs0; response_count:0; response_revision:8304; }","duration":"188.624485ms","start":"2026-04-20T08:26:52.873402Z","end":"2026-04-20T08:26:53.062026Z","steps":["trace[216385914] 'agreement among raft nodes before linearized reading' (duration: 188.349677ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:26:53.062067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.443457ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"warn","ts":"2026-04-20T08:26:53.062087Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:26:52.660273Z","time spent":"401.798513ms","remote":"127.0.0.1:33350","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":13,"response size":30,"request content":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true "} {"level":"info","ts":"2026-04-20T08:26:53.062119Z","caller":"traceutil/trace.go:171","msg":"trace[704911296] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8304; }","duration":"146.965111ms","start":"2026-04-20T08:26:52.915137Z","end":"2026-04-20T08:26:53.062102Z","steps":["trace[704911296] 'agreement among raft nodes before linearized reading' (duration: 146.252892ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:27:04.362327Z","caller":"traceutil/trace.go:171","msg":"trace[1931434078] transaction","detail":"{read_only:false; response_revision:8371; number_of_response:1; }","duration":"115.938063ms","start":"2026-04-20T08:27:04.24635Z","end":"2026-04-20T08:27:04.362288Z","steps":["trace[1931434078] 'process raft request' (duration: 45.361686ms)","trace[1931434078] 'compare' (duration: 70.094855ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T08:27:04.615007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.273939ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectstores/\" range_end:\"/registry/ceph.rook.io/cephobjectstores0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-20T08:27:04.615077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.880982ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephblockpools/\" range_end:\"/registry/ceph.rook.io/cephblockpools0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-20T08:27:04.615148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.475338ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectstores/\" range_end:\"/registry/ceph.rook.io/cephobjectstores0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T08:27:04.615148Z","caller":"traceutil/trace.go:171","msg":"trace[1474679923] range","detail":"{range_begin:/registry/ceph.rook.io/cephblockpools/; range_end:/registry/ceph.rook.io/cephblockpools0; response_count:0; response_revision:8371; }","duration":"107.980775ms","start":"2026-04-20T08:27:04.507151Z","end":"2026-04-20T08:27:04.615132Z","steps":["trace[1474679923] 'range keys from in-memory index tree' (duration: 107.841811ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:27:04.615181Z","caller":"traceutil/trace.go:171","msg":"trace[1537020931] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectstores/; range_end:/registry/ceph.rook.io/cephobjectstores0; response_count:0; response_revision:8371; }","duration":"142.52417ms","start":"2026-04-20T08:27:04.472648Z","end":"2026-04-20T08:27:04.615172Z","steps":["trace[1537020931] 'range keys from in-memory index tree' (duration: 142.433567ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:27:04.615348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.202711ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectrealms/\" range_end:\"/registry/ceph.rook.io/cephobjectrealms0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T08:27:04.615374Z","caller":"traceutil/trace.go:171","msg":"trace[798100681] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectrealms/; range_end:/registry/ceph.rook.io/cephobjectrealms0; response_count:0; response_revision:8371; }","duration":"126.265552ms","start":"2026-04-20T08:27:04.4891Z","end":"2026-04-20T08:27:04.615366Z","steps":["trace[798100681] 'range keys from in-memory index tree' (duration: 126.029617ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:27:04.615501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.19602ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectrealms/\" range_end:\"/registry/ceph.rook.io/cephobjectrealms0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T08:27:04.615096Z","caller":"traceutil/trace.go:171","msg":"trace[1186934106] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectstores/; range_end:/registry/ceph.rook.io/cephobjectstores0; response_count:0; response_revision:8371; }","duration":"143.396822ms","start":"2026-04-20T08:27:04.471675Z","end":"2026-04-20T08:27:04.615072Z","steps":["trace[1186934106] 'count revisions from in-memory index tree' (duration: 142.887789ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:27:04.615524Z","caller":"traceutil/trace.go:171","msg":"trace[1772582481] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectrealms/; range_end:/registry/ceph.rook.io/cephobjectrealms0; response_count:0; response_revision:8371; }","duration":"126.218061ms","start":"2026-04-20T08:27:04.489296Z","end":"2026-04-20T08:27:04.615514Z","steps":["trace[1772582481] 'count revisions from in-memory index tree' (duration: 126.101158ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:27:04.61562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.44493ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephblockpools/\" range_end:\"/registry/ceph.rook.io/cephblockpools0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T08:27:04.615662Z","caller":"traceutil/trace.go:171","msg":"trace[1907656875] range","detail":"{range_begin:/registry/ceph.rook.io/cephblockpools/; range_end:/registry/ceph.rook.io/cephblockpools0; response_count:0; response_revision:8371; }","duration":"109.505532ms","start":"2026-04-20T08:27:04.50614Z","end":"2026-04-20T08:27:04.615645Z","steps":["trace[1907656875] 'range keys from in-memory index tree' (duration: 109.40323ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:27:04.615678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.415719ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephblockpools/\" range_end:\"/registry/ceph.rook.io/cephblockpools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T08:27:04.615778Z","caller":"traceutil/trace.go:171","msg":"trace[299786108] range","detail":"{range_begin:/registry/ceph.rook.io/cephblockpools/; range_end:/registry/ceph.rook.io/cephblockpools0; response_count:0; response_revision:8371; }","duration":"109.534793ms","start":"2026-04-20T08:27:04.506225Z","end":"2026-04-20T08:27:04.615759Z","steps":["trace[299786108] 'count revisions from in-memory index tree' (duration: 109.352578ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:27:04.616098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.357236ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectstores/\" range_end:\"/registry/ceph.rook.io/cephobjectstores0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T08:27:04.616196Z","caller":"traceutil/trace.go:171","msg":"trace[2130517879] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectstores/; range_end:/registry/ceph.rook.io/cephobjectstores0; response_count:0; response_revision:8371; }","duration":"144.502709ms","start":"2026-04-20T08:27:04.471675Z","end":"2026-04-20T08:27:04.616178Z","steps":["trace[2130517879] 'range keys from in-memory index tree' (duration: 144.253993ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:27:04.616258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.146969ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectrealms/\" range_end:\"/registry/ceph.rook.io/cephobjectrealms0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T08:27:04.616335Z","caller":"traceutil/trace.go:171","msg":"trace[989429527] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectrealms/; range_end:/registry/ceph.rook.io/cephobjectrealms0; response_count:0; response_revision:8371; }","duration":"127.590716ms","start":"2026-04-20T08:27:04.488732Z","end":"2026-04-20T08:27:04.616323Z","steps":["trace[989429527] 'range keys from in-memory index tree' (duration: 126.030896ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:27:05.559139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.524308ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T08:27:05.559435Z","caller":"traceutil/trace.go:171","msg":"trace[1240494415] transaction","detail":"{read_only:false; response_revision:8376; number_of_response:1; }","duration":"355.136393ms","start":"2026-04-20T08:27:05.204257Z","end":"2026-04-20T08:27:05.559393Z","steps":["trace[1240494415] 'process raft request' (duration: 355.034621ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:27:05.559456Z","caller":"traceutil/trace.go:171","msg":"trace[1437836681] transaction","detail":"{read_only:false; response_revision:8375; number_of_response:1; }","duration":"355.835271ms","start":"2026-04-20T08:27:05.203579Z","end":"2026-04-20T08:27:05.559414Z","steps":["trace[1437836681] 'process raft request' (duration: 127.932333ms)","trace[1437836681] 'compare' (duration: 227.361114ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T08:27:05.559529Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:27:05.204233Z","time spent":"355.254647ms","remote":"127.0.0.1:33218","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":539,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T08:27:05.559624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:27:05.203535Z","time spent":"355.995215ms","remote":"127.0.0.1:33218","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T08:27:06.143542Z","caller":"traceutil/trace.go:171","msg":"trace[1893841756] transaction","detail":"{read_only:false; response_revision:8378; number_of_response:1; }","duration":"111.695118ms","start":"2026-04-20T08:27:06.031825Z","end":"2026-04-20T08:27:06.14352Z","steps":["trace[1893841756] 'process raft request' (duration: 111.412031ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:27:06.143743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.979848ms","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-04-20T08:27:06.143505Z","caller":"traceutil/trace.go:171","msg":"trace[830326585] linearizableReadLoop","detail":"{readStateIndex:8667; appliedIndex:8666; }","duration":"102.719152ms","start":"2026-04-20T08:27:06.040745Z","end":"2026-04-20T08:27:06.143464Z","steps":["trace[830326585] 'read index received' (duration: 102.498866ms)","trace[830326585] 'applied index is now lower than readState.Index' (duration: 218.876µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T08:27:06.143793Z","caller":"traceutil/trace.go:171","msg":"trace[165270891] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8378; }","duration":"103.103292ms","start":"2026-04-20T08:27:06.04068Z","end":"2026-04-20T08:27:06.143783Z","steps":["trace[165270891] 'agreement among raft nodes before linearized reading' (duration: 102.902077ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:27:31.460041Z","caller":"traceutil/trace.go:171","msg":"trace[15372903] transaction","detail":"{read_only:false; response_revision:8567; number_of_response:1; }","duration":"120.113688ms","start":"2026-04-20T08:27:31.339885Z","end":"2026-04-20T08:27:31.459999Z","steps":["trace[15372903] 'process raft request' (duration: 102.711612ms)","trace[15372903] 'compare' (duration: 16.514644ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T08:27:34.477932Z","caller":"traceutil/trace.go:171","msg":"trace[1436513189] linearizableReadLoop","detail":"{readStateIndex:8879; appliedIndex:8878; }","duration":"143.450183ms","start":"2026-04-20T08:27:34.334447Z","end":"2026-04-20T08:27:34.477897Z","steps":["trace[1436513189] 'read index received' (duration: 143.177936ms)","trace[1436513189] 'applied index is now lower than readState.Index' (duration: 271.357µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T08:27:34.478008Z","caller":"traceutil/trace.go:171","msg":"trace[1940395788] transaction","detail":"{read_only:false; response_revision:8583; number_of_response:1; }","duration":"176.247583ms","start":"2026-04-20T08:27:34.301713Z","end":"2026-04-20T08:27:34.477961Z","steps":["trace[1940395788] 'process raft request' (duration: 175.984717ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:27:34.478185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.71999ms","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-04-20T08:27:34.478257Z","caller":"traceutil/trace.go:171","msg":"trace[341486452] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8583; }","duration":"143.849683ms","start":"2026-04-20T08:27:34.334391Z","end":"2026-04-20T08:27:34.478241Z","steps":["trace[341486452] 'agreement among raft nodes before linearized reading' (duration: 143.659959ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:27:34.478254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.887389ms","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-04-20T08:27:34.478304Z","caller":"traceutil/trace.go:171","msg":"trace[1555554276] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8583; }","duration":"142.96504ms","start":"2026-04-20T08:27:34.335324Z","end":"2026-04-20T08:27:34.478289Z","steps":["trace[1555554276] 'agreement among raft nodes before linearized reading' (duration: 142.749055ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:27:36.699408Z","caller":"traceutil/trace.go:171","msg":"trace[2117752925] transaction","detail":"{read_only:false; response_revision:8597; number_of_response:1; }","duration":"148.366315ms","start":"2026-04-20T08:27:36.551006Z","end":"2026-04-20T08:27:36.699372Z","steps":["trace[2117752925] 'process raft request' (duration: 135.225566ms)","trace[2117752925] 'compare' (duration: 12.958895ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T08:27:37.163997Z","caller":"traceutil/trace.go:171","msg":"trace[824090015] linearizableReadLoop","detail":"{readStateIndex:8895; appliedIndex:8894; }","duration":"229.567518ms","start":"2026-04-20T08:27:36.934403Z","end":"2026-04-20T08:27:37.16397Z","steps":["trace[824090015] 'read index received' (duration: 229.416384ms)","trace[824090015] 'applied index is now lower than readState.Index' (duration: 150.174µs)"],"step_count":2} {"level":"warn","ts":"2026-04-20T08:27:37.164133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.714632ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T08:27:37.164165Z","caller":"traceutil/trace.go:171","msg":"trace[695659792] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8598; }","duration":"229.783134ms","start":"2026-04-20T08:27:36.934372Z","end":"2026-04-20T08:27:37.164156Z","steps":["trace[695659792] 'agreement among raft nodes before linearized reading' (duration: 229.712603ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:27:37.164241Z","caller":"traceutil/trace.go:171","msg":"trace[1213511300] transaction","detail":"{read_only:false; response_revision:8598; number_of_response:1; }","duration":"239.729214ms","start":"2026-04-20T08:27:36.92444Z","end":"2026-04-20T08:27:37.164169Z","steps":["trace[1213511300] 'process raft request' (duration: 239.328603ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:27:37.318807Z","caller":"traceutil/trace.go:171","msg":"trace[905355877] linearizableReadLoop","detail":"{readStateIndex:8896; appliedIndex:8895; }","duration":"154.706044ms","start":"2026-04-20T08:27:37.164065Z","end":"2026-04-20T08:27:37.318771Z","steps":["trace[905355877] 'read index received' (duration: 154.52078ms)","trace[905355877] 'applied index is now lower than readState.Index' (duration: 183.224µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T08:27:37.318947Z","caller":"traceutil/trace.go:171","msg":"trace[1086402405] transaction","detail":"{read_only:false; response_revision:8599; number_of_response:1; }","duration":"271.689424ms","start":"2026-04-20T08:27:37.047209Z","end":"2026-04-20T08:27:37.318898Z","steps":["trace[1086402405] 'process raft request' (duration: 271.331255ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:27:37.31906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.715888ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T08:27:37.319135Z","caller":"traceutil/trace.go:171","msg":"trace[1094406466] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:8599; }","duration":"343.845091ms","start":"2026-04-20T08:27:36.975257Z","end":"2026-04-20T08:27:37.319102Z","steps":["trace[1094406466] 'agreement among raft nodes before linearized reading' (duration: 343.709518ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:27:37.319193Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:27:36.975239Z","time spent":"343.940613ms","remote":"127.0.0.1:43100","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true "} {"level":"warn","ts":"2026-04-20T08:27:37.329194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.824482ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T08:27:37.329258Z","caller":"traceutil/trace.go:171","msg":"trace[1057357446] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8600; }","duration":"163.949535ms","start":"2026-04-20T08:27:37.165293Z","end":"2026-04-20T08:27:37.329243Z","steps":["trace[1057357446] 'agreement among raft nodes before linearized reading' (duration: 163.809292ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:27:47.109673Z","caller":"traceutil/trace.go:171","msg":"trace[761619357] transaction","detail":"{read_only:false; number_of_response:1; response_revision:8696; }","duration":"146.307864ms","start":"2026-04-20T08:27:46.963327Z","end":"2026-04-20T08:27:47.109635Z","steps":["trace[761619357] 'process raft request' (duration: 140.132289ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:27:47.695484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.485853ms","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-04-20T08:27:47.695577Z","caller":"traceutil/trace.go:171","msg":"trace[1020367448] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8698; }","duration":"157.635907ms","start":"2026-04-20T08:27:47.537921Z","end":"2026-04-20T08:27:47.695557Z","steps":["trace[1020367448] 'range keys from in-memory index tree' (duration: 157.210666ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:27:47.839901Z","caller":"traceutil/trace.go:171","msg":"trace[587917727] transaction","detail":"{read_only:false; response_revision:8699; number_of_response:1; }","duration":"139.601546ms","start":"2026-04-20T08:27:47.700273Z","end":"2026-04-20T08:27:47.839875Z","steps":["trace[587917727] 'process raft request' (duration: 139.447352ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:27:47.964685Z","caller":"traceutil/trace.go:171","msg":"trace[1900445486] transaction","detail":"{read_only:false; response_revision:8700; number_of_response:1; }","duration":"119.434482ms","start":"2026-04-20T08:27:47.845208Z","end":"2026-04-20T08:27:47.964642Z","steps":["trace[1900445486] 'process raft request' (duration: 55.386397ms)","trace[1900445486] 'compare' (duration: 63.86708ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T08:27:47.968659Z","caller":"traceutil/trace.go:171","msg":"trace[1033675930] transaction","detail":"{read_only:false; response_revision:8701; number_of_response:1; }","duration":"122.910237ms","start":"2026-04-20T08:27:47.845724Z","end":"2026-04-20T08:27:47.968634Z","steps":["trace[1033675930] 'process raft request' (duration: 122.451876ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:27:47.968971Z","caller":"traceutil/trace.go:171","msg":"trace[2070367737] transaction","detail":"{read_only:false; response_revision:8702; number_of_response:1; }","duration":"113.584323ms","start":"2026-04-20T08:27:47.855342Z","end":"2026-04-20T08:27:47.968926Z","steps":["trace[2070367737] 'process raft request' (duration: 113.061211ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:27:47.96918Z","caller":"traceutil/trace.go:171","msg":"trace[775288733] linearizableReadLoop","detail":"{readStateIndex:9002; appliedIndex:9000; }","duration":"114.326193ms","start":"2026-04-20T08:27:47.854805Z","end":"2026-04-20T08:27:47.969131Z","steps":["trace[775288733] 'read index received' (duration: 45.787476ms)","trace[775288733] 'applied index is now lower than readState.Index' (duration: 68.536627ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T08:27:47.969398Z","caller":"traceutil/trace.go:171","msg":"trace[1618912181] transaction","detail":"{read_only:false; response_revision:8703; number_of_response:1; }","duration":"102.744644ms","start":"2026-04-20T08:27:47.866638Z","end":"2026-04-20T08:27:47.969383Z","steps":["trace[1618912181] 'process raft request' (duration: 101.850021ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:27:47.969554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.735323ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-nsz79\" ","response":"range_response_count:1 size:4645"} {"level":"info","ts":"2026-04-20T08:27:47.969612Z","caller":"traceutil/trace.go:171","msg":"trace[881296148] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-nsz79; range_end:; response_count:1; response_revision:8703; }","duration":"114.823886ms","start":"2026-04-20T08:27:47.854773Z","end":"2026-04-20T08:27:47.969597Z","steps":["trace[881296148] 'agreement among raft nodes before linearized reading' (duration: 114.625781ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:27:47.970847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.6376ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclusters/openstack/ceph\" ","response":"range_response_count:1 size:5732"} {"level":"info","ts":"2026-04-20T08:27:47.97099Z","caller":"traceutil/trace.go:171","msg":"trace[1236170959] range","detail":"{range_begin:/registry/ceph.rook.io/cephclusters/openstack/ceph; range_end:; response_count:1; response_revision:8703; }","duration":"104.850645ms","start":"2026-04-20T08:27:47.866115Z","end":"2026-04-20T08:27:47.970966Z","steps":["trace[1236170959] 'agreement among raft nodes before linearized reading' (duration: 103.373468ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:28:30.347525Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000024b9.wal"} {"level":"info","ts":"2026-04-20T08:29:05.226153Z","caller":"traceutil/trace.go:171","msg":"trace[2135959219] transaction","detail":"{read_only:false; response_revision:9451; number_of_response:1; }","duration":"142.483019ms","start":"2026-04-20T08:29:05.083629Z","end":"2026-04-20T08:29:05.226112Z","steps":["trace[2135959219] 'process raft request' (duration: 101.949587ms)","trace[2135959219] 'compare' (duration: 40.218644ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T08:29:05.22653Z","caller":"traceutil/trace.go:171","msg":"trace[1833566429] transaction","detail":"{read_only:false; response_revision:9452; number_of_response:1; }","duration":"140.759835ms","start":"2026-04-20T08:29:05.085743Z","end":"2026-04-20T08:29:05.226503Z","steps":["trace[1833566429] 'process raft request' (duration: 140.270793ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:29:36.421929Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"dcb0af7a3afe1d6d","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-20T08:29:36.426532Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-20T08:29:36.426646Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-20T08:31:52.321401Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8299} {"level":"info","ts":"2026-04-20T08:31:52.405391Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8299,"took":"81.630806ms","hash":4126908806,"current-db-size-bytes":57032704,"current-db-size":"57 MB","current-db-size-in-use-bytes":25985024,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-04-20T08:31:52.405464Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4126908806,"revision":8299,"compact-revision":6077} {"level":"info","ts":"2026-04-20T08:36:52.328785Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10694} {"level":"info","ts":"2026-04-20T08:36:52.410097Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10694,"took":"78.735431ms","hash":3584373381,"current-db-size-bytes":57032704,"current-db-size":"57 MB","current-db-size-in-use-bytes":20705280,"current-db-size-in-use":"21 MB"} {"level":"info","ts":"2026-04-20T08:36:52.410175Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3584373381,"revision":10694,"compact-revision":8299}