{"level":"warn","ts":"2026-06-16T11:38:06.133593Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-16T11:38:06.13373Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.238:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.238:2380","--initial-cluster=instance=https://199.204.45.238:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.238:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.238:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-06-16T11:38:06.133815Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-16T11:38:06.133831Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.238:2380"]} {"level":"info","ts":"2026-06-16T11:38:06.133856Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-06-16T11:38:06.134711Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.238:2379"]} {"level":"info","ts":"2026-06-16T11:38:06.134804Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.238:2380"],"listen-peer-urls":["https://199.204.45.238:2380"],"advertise-client-urls":["https://199.204.45.238:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.238:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.238:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-06-16T11:38:06.137595Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.556039ms"} {"level":"info","ts":"2026-06-16T11:38:06.14241Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"d7dbc9f5893cc1f6","cluster-id":"823d1d08ab21430c"} {"level":"info","ts":"2026-06-16T11:38:06.1425Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 switched to configuration voters=()"} {"level":"info","ts":"2026-06-16T11:38:06.142527Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 became follower at term 0"} {"level":"info","ts":"2026-06-16T11:38:06.142541Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft d7dbc9f5893cc1f6 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-16T11:38:06.142557Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 became follower at term 1"} {"level":"info","ts":"2026-06-16T11:38:06.142592Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 switched to configuration voters=(15554247794460770806)"} {"level":"warn","ts":"2026-06-16T11:38:06.148163Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-16T11:38:06.150134Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-16T11:38:06.153239Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-06-16T11:38:06.156355Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"d7dbc9f5893cc1f6","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-16T11:38:06.156509Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"d7dbc9f5893cc1f6","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-16T11:38:06.156675Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-16T11:38:06.156809Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-16T11:38:06.156832Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-16T11:38:06.15847Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 switched to configuration voters=(15554247794460770806)"} {"level":"info","ts":"2026-06-16T11:38:06.158586Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"823d1d08ab21430c","local-member-id":"d7dbc9f5893cc1f6","added-peer-id":"d7dbc9f5893cc1f6","added-peer-peer-urls":["https://199.204.45.238:2380"]} {"level":"info","ts":"2026-06-16T11:38:06.161498Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-06-16T11:38:06.16167Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.238:2380"} {"level":"info","ts":"2026-06-16T11:38:06.161731Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.238:2380"} {"level":"info","ts":"2026-06-16T11:38:06.16189Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"d7dbc9f5893cc1f6","initial-advertise-peer-urls":["https://199.204.45.238:2380"],"listen-peer-urls":["https://199.204.45.238:2380"],"advertise-client-urls":["https://199.204.45.238:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.238:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-16T11:38:06.161947Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-16T11:38:06.643393Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 is starting a new election at term 1"} {"level":"info","ts":"2026-06-16T11:38:06.643463Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-16T11:38:06.643501Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 received MsgPreVoteResp from d7dbc9f5893cc1f6 at term 1"} {"level":"info","ts":"2026-06-16T11:38:06.643517Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 became candidate at term 2"} {"level":"info","ts":"2026-06-16T11:38:06.643527Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 received MsgVoteResp from d7dbc9f5893cc1f6 at term 2"} {"level":"info","ts":"2026-06-16T11:38:06.643538Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 became leader at term 2"} {"level":"info","ts":"2026-06-16T11:38:06.643548Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: d7dbc9f5893cc1f6 elected leader d7dbc9f5893cc1f6 at term 2"} {"level":"info","ts":"2026-06-16T11:38:06.645006Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-16T11:38:06.645017Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"d7dbc9f5893cc1f6","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.238:2379]}","request-path":"/0/members/d7dbc9f5893cc1f6/attributes","cluster-id":"823d1d08ab21430c","publish-timeout":"7s"} {"level":"info","ts":"2026-06-16T11:38:06.645553Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-16T11:38:06.645672Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-16T11:38:06.646385Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-16T11:38:06.646549Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-16T11:38:06.647741Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"823d1d08ab21430c","local-member-id":"d7dbc9f5893cc1f6","cluster-version":"3.5"} {"level":"info","ts":"2026-06-16T11:38:06.647869Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-16T11:38:06.647924Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-16T11:38:06.648954Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-16T11:38:06.649235Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.238:2379"} {"level":"warn","ts":"2026-06-16T11:38:51.918215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.09794ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-16T11:38:51.918361Z","caller":"traceutil/trace.go:171","msg":"trace[1352652275] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"195.944243ms","start":"2026-06-16T11:38:51.722398Z","end":"2026-06-16T11:38:51.918343Z","steps":["trace[1352652275] 'process raft request' (duration: 87.276483ms)","trace[1352652275] 'compare' (duration: 107.927197ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T11:38:52.427799Z","caller":"traceutil/trace.go:171","msg":"trace[1887258016] linearizableReadLoop","detail":"{readStateIndex:623; appliedIndex:622; }","duration":"101.914101ms","start":"2026-06-16T11:38:52.32585Z","end":"2026-06-16T11:38:52.427764Z","steps":["trace[1887258016] 'read index received' (duration: 96.912536ms)","trace[1887258016] 'applied index is now lower than readState.Index' (duration: 5.000205ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T11:38:52.428163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.304828ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-16T11:38:52.428202Z","caller":"traceutil/trace.go:171","msg":"trace[1895181524] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:598; }","duration":"102.37152ms","start":"2026-06-16T11:38:52.325819Z","end":"2026-06-16T11:38:52.428191Z","steps":["trace[1895181524] 'agreement among raft nodes before linearized reading' (duration: 102.069784ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:38:52.428156Z","caller":"traceutil/trace.go:171","msg":"trace[1942175249] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"112.847328ms","start":"2026-06-16T11:38:52.315051Z","end":"2026-06-16T11:38:52.427898Z","steps":["trace[1942175249] 'process raft request' (duration: 108.16709ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:39:08.515532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.623285ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-16T11:39:08.515662Z","caller":"traceutil/trace.go:171","msg":"trace[724236188] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:757; }","duration":"187.846119ms","start":"2026-06-16T11:39:08.327792Z","end":"2026-06-16T11:39:08.515638Z","steps":["trace[724236188] 'range keys from in-memory index tree' (duration: 187.443532ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:40:32.371778Z","caller":"traceutil/trace.go:171","msg":"trace[1404888394] linearizableReadLoop","detail":"{readStateIndex:1944; appliedIndex:1943; }","duration":"167.113638ms","start":"2026-06-16T11:40:32.204625Z","end":"2026-06-16T11:40:32.371739Z","steps":["trace[1404888394] 'read index received' (duration: 166.833432ms)","trace[1404888394] 'applied index is now lower than readState.Index' (duration: 278.936µs)"],"step_count":2} {"level":"info","ts":"2026-06-16T11:40:32.371844Z","caller":"traceutil/trace.go:171","msg":"trace[1529966786] transaction","detail":"{read_only:false; response_revision:1869; number_of_response:1; }","duration":"172.434868ms","start":"2026-06-16T11:40:32.199363Z","end":"2026-06-16T11:40:32.371798Z","steps":["trace[1529966786] 'process raft request' (duration: 172.101001ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:40:32.372015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.337992ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-16T11:40:32.372089Z","caller":"traceutil/trace.go:171","msg":"trace[1204239896] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:1869; }","duration":"167.469324ms","start":"2026-06-16T11:40:32.204597Z","end":"2026-06-16T11:40:32.372067Z","steps":["trace[1204239896] 'agreement among raft nodes before linearized reading' (duration: 167.28168ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:40:43.605714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.674007ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-16T11:40:43.605844Z","caller":"traceutil/trace.go:171","msg":"trace[670181340] linearizableReadLoop","detail":"{readStateIndex:2040; appliedIndex:2039; }","duration":"278.329545ms","start":"2026-06-16T11:40:43.327495Z","end":"2026-06-16T11:40:43.605825Z","steps":["trace[670181340] 'read index received' (duration: 63.393623ms)","trace[670181340] 'applied index is now lower than readState.Index' (duration: 214.934382ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T11:40:43.605861Z","caller":"traceutil/trace.go:171","msg":"trace[305562063] transaction","detail":"{read_only:false; response_revision:1962; number_of_response:1; }","duration":"318.816671ms","start":"2026-06-16T11:40:43.28701Z","end":"2026-06-16T11:40:43.605827Z","steps":["trace[305562063] 'process raft request' (duration: 103.792707ms)","trace[305562063] 'compare' (duration: 214.472034ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T11:40:43.605945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.459617ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-16T11:40:43.605979Z","caller":"traceutil/trace.go:171","msg":"trace[729425949] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1962; }","duration":"278.547048ms","start":"2026-06-16T11:40:43.327421Z","end":"2026-06-16T11:40:43.605968Z","steps":["trace[729425949] 'agreement among raft nodes before linearized reading' (duration: 278.490147ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:40:43.606067Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T11:40:43.286984Z","time spent":"318.969973ms","remote":"127.0.0.1:32838","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T11:40:43.658654Z","caller":"traceutil/trace.go:171","msg":"trace[1357400908] transaction","detail":"{read_only:false; response_revision:1963; number_of_response:1; }","duration":"203.138469ms","start":"2026-06-16T11:40:43.455413Z","end":"2026-06-16T11:40:43.658551Z","steps":["trace[1357400908] 'process raft request' (duration: 202.945986ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:41:22.86682Z","caller":"traceutil/trace.go:171","msg":"trace[1939773697] transaction","detail":"{read_only:false; response_revision:2188; number_of_response:1; }","duration":"126.57233ms","start":"2026-06-16T11:41:22.740218Z","end":"2026-06-16T11:41:22.86679Z","steps":["trace[1939773697] 'process raft request' (duration: 126.415397ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:41:23.105292Z","caller":"traceutil/trace.go:171","msg":"trace[2021398871] transaction","detail":"{read_only:false; response_revision:2189; number_of_response:1; }","duration":"222.988023ms","start":"2026-06-16T11:41:22.882272Z","end":"2026-06-16T11:41:23.10526Z","steps":["trace[2021398871] 'process raft request' (duration: 210.836127ms)","trace[2021398871] 'compare' (duration: 11.963892ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T11:41:23.10568Z","caller":"traceutil/trace.go:171","msg":"trace[1724322615] transaction","detail":"{read_only:false; response_revision:2190; number_of_response:1; }","duration":"207.202837ms","start":"2026-06-16T11:41:22.898399Z","end":"2026-06-16T11:41:23.105601Z","steps":["trace[1724322615] 'process raft request' (duration: 206.800969ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:42:15.732645Z","caller":"traceutil/trace.go:171","msg":"trace[1386765598] transaction","detail":"{read_only:false; response_revision:2646; number_of_response:1; }","duration":"164.490546ms","start":"2026-06-16T11:42:15.56811Z","end":"2026-06-16T11:42:15.7326Z","steps":["trace[1386765598] 'process raft request' (duration: 164.259122ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:42:49.522341Z","caller":"traceutil/trace.go:171","msg":"trace[1269761027] transaction","detail":"{read_only:false; response_revision:2850; number_of_response:1; }","duration":"101.036175ms","start":"2026-06-16T11:42:49.421272Z","end":"2026-06-16T11:42:49.522308Z","steps":["trace[1269761027] 'process raft request' (duration: 100.836851ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:45:30.463616Z","caller":"traceutil/trace.go:171","msg":"trace[1399291013] linearizableReadLoop","detail":"{readStateIndex:4048; appliedIndex:4047; }","duration":"123.291163ms","start":"2026-06-16T11:45:30.340295Z","end":"2026-06-16T11:45:30.463586Z","steps":["trace[1399291013] 'read index received' (duration: 123.228532ms)","trace[1399291013] 'applied index is now lower than readState.Index' (duration: 61.101µs)"],"step_count":2} {"level":"warn","ts":"2026-06-16T11:45:30.463883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.562128ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-06-16T11:45:30.464022Z","caller":"traceutil/trace.go:171","msg":"trace[307521338] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:3897; }","duration":"123.751992ms","start":"2026-06-16T11:45:30.340251Z","end":"2026-06-16T11:45:30.464003Z","steps":["trace[307521338] 'agreement among raft nodes before linearized reading' (duration: 123.461266ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:45:30.508685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.025642ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-06-16T11:45:30.508761Z","caller":"traceutil/trace.go:171","msg":"trace[851972577] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:3898; }","duration":"129.147454ms","start":"2026-06-16T11:45:30.379597Z","end":"2026-06-16T11:45:30.508744Z","steps":["trace[851972577] 'agreement among raft nodes before linearized reading' (duration: 128.911399ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:46:49.512099Z","caller":"traceutil/trace.go:171","msg":"trace[1633240502] transaction","detail":"{read_only:false; response_revision:4860; number_of_response:1; }","duration":"171.494275ms","start":"2026-06-16T11:46:49.34057Z","end":"2026-06-16T11:46:49.512065Z","steps":["trace[1633240502] 'process raft request' (duration: 171.280351ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:46:49.56061Z","caller":"traceutil/trace.go:171","msg":"trace[1075761169] linearizableReadLoop","detail":"{readStateIndex:5047; appliedIndex:5045; }","duration":"107.163835ms","start":"2026-06-16T11:46:49.453409Z","end":"2026-06-16T11:46:49.560573Z","steps":["trace[1075761169] 'read index received' (duration: 58.313801ms)","trace[1075761169] 'applied index is now lower than readState.Index' (duration: 48.848714ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T11:46:49.560675Z","caller":"traceutil/trace.go:171","msg":"trace[310023059] transaction","detail":"{read_only:false; response_revision:4861; number_of_response:1; }","duration":"161.613139ms","start":"2026-06-16T11:46:49.399028Z","end":"2026-06-16T11:46:49.560641Z","steps":["trace[310023059] 'process raft request' (duration: 161.387475ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:46:49.56093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.484722ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-e13e6c4a-4ae1-4f35-9647-41ad1b18ed38\" ","response":"range_response_count:1 size:3774"} {"level":"info","ts":"2026-06-16T11:46:49.560976Z","caller":"traceutil/trace.go:171","msg":"trace[1979991450] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-e13e6c4a-4ae1-4f35-9647-41ad1b18ed38; range_end:; response_count:1; response_revision:4861; }","duration":"107.601884ms","start":"2026-06-16T11:46:49.453359Z","end":"2026-06-16T11:46:49.560961Z","steps":["trace[1979991450] 'agreement among raft nodes before linearized reading' (duration: 107.338558ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:46:54.641776Z","caller":"traceutil/trace.go:171","msg":"trace[554066089] transaction","detail":"{read_only:false; response_revision:5056; number_of_response:1; }","duration":"150.204754ms","start":"2026-06-16T11:46:54.491532Z","end":"2026-06-16T11:46:54.641736Z","steps":["trace[554066089] 'process raft request' (duration: 135.604517ms)","trace[554066089] 'compare' (duration: 14.417924ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T11:46:54.652019Z","caller":"traceutil/trace.go:171","msg":"trace[1623942877] transaction","detail":"{read_only:false; response_revision:5057; number_of_response:1; }","duration":"149.953979ms","start":"2026-06-16T11:46:54.502035Z","end":"2026-06-16T11:46:54.651989Z","steps":["trace[1623942877] 'process raft request' (duration: 149.552881ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:47:02.881487Z","caller":"traceutil/trace.go:171","msg":"trace[1892310439] transaction","detail":"{read_only:false; response_revision:5244; number_of_response:1; }","duration":"108.825827ms","start":"2026-06-16T11:47:02.772622Z","end":"2026-06-16T11:47:02.881447Z","steps":["trace[1892310439] 'process raft request' (duration: 41.500088ms)","trace[1892310439] 'compare' (duration: 66.980653ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T11:47:02.933213Z","caller":"traceutil/trace.go:171","msg":"trace[1773026140] transaction","detail":"{read_only:false; response_revision:5245; number_of_response:1; }","duration":"104.561983ms","start":"2026-06-16T11:47:02.828627Z","end":"2026-06-16T11:47:02.933189Z","steps":["trace[1773026140] 'process raft request' (duration: 104.448721ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:47:08.634568Z","caller":"traceutil/trace.go:171","msg":"trace[1274551417] transaction","detail":"{read_only:false; response_revision:5328; number_of_response:1; }","duration":"221.363339ms","start":"2026-06-16T11:47:08.413171Z","end":"2026-06-16T11:47:08.634534Z","steps":["trace[1274551417] 'process raft request' (duration: 221.137595ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:47:08.830877Z","caller":"traceutil/trace.go:171","msg":"trace[873359500] transaction","detail":"{read_only:false; response_revision:5331; number_of_response:1; }","duration":"139.599775ms","start":"2026-06-16T11:47:08.691251Z","end":"2026-06-16T11:47:08.830851Z","steps":["trace[873359500] 'process raft request' (duration: 133.19685ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:47:08.830932Z","caller":"traceutil/trace.go:171","msg":"trace[2108083280] transaction","detail":"{read_only:false; response_revision:5333; number_of_response:1; }","duration":"131.590347ms","start":"2026-06-16T11:47:08.699321Z","end":"2026-06-16T11:47:08.830912Z","steps":["trace[2108083280] 'process raft request' (duration: 131.512405ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:47:08.831046Z","caller":"traceutil/trace.go:171","msg":"trace[233758657] transaction","detail":"{read_only:false; response_revision:5332; number_of_response:1; }","duration":"138.699127ms","start":"2026-06-16T11:47:08.69231Z","end":"2026-06-16T11:47:08.831009Z","steps":["trace[233758657] 'process raft request' (duration: 138.454152ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:47:17.015697Z","caller":"traceutil/trace.go:171","msg":"trace[1902956240] transaction","detail":"{read_only:false; response_revision:5544; number_of_response:1; }","duration":"157.660492ms","start":"2026-06-16T11:47:16.858005Z","end":"2026-06-16T11:47:17.015666Z","steps":["trace[1902956240] 'process raft request' (duration: 136.692518ms)","trace[1902956240] 'compare' (duration: 20.636668ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T11:47:17.206348Z","caller":"traceutil/trace.go:171","msg":"trace[166412111] linearizableReadLoop","detail":"{readStateIndex:5753; appliedIndex:5752; }","duration":"133.196429ms","start":"2026-06-16T11:47:17.073098Z","end":"2026-06-16T11:47:17.206294Z","steps":["trace[166412111] 'read index received' (duration: 133.071496ms)","trace[166412111] 'applied index is now lower than readState.Index' (duration: 123.652µs)"],"step_count":2} {"level":"info","ts":"2026-06-16T11:47:17.206424Z","caller":"traceutil/trace.go:171","msg":"trace[1465389210] transaction","detail":"{read_only:false; response_revision:5546; number_of_response:1; }","duration":"201.826464ms","start":"2026-06-16T11:47:17.004534Z","end":"2026-06-16T11:47:17.20636Z","steps":["trace[1465389210] 'process raft request' (duration: 201.61779ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:47:17.207273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.164319ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:57 size:2224963"} {"level":"info","ts":"2026-06-16T11:47:17.20732Z","caller":"traceutil/trace.go:171","msg":"trace[1366244239] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:57; response_revision:5546; }","duration":"134.26541ms","start":"2026-06-16T11:47:17.073042Z","end":"2026-06-16T11:47:17.207307Z","steps":["trace[1366244239] 'agreement among raft nodes before linearized reading' (duration: 133.421683ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:48:06.672723Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2947} {"level":"info","ts":"2026-06-16T11:48:06.747821Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2947,"took":"70.152968ms","hash":2981717071,"current-db-size-bytes":58159104,"current-db-size":"58 MB","current-db-size-in-use-bytes":33427456,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-06-16T11:48:06.747891Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2981717071,"revision":2947,"compact-revision":-1} {"level":"info","ts":"2026-06-16T11:48:08.189145Z","caller":"traceutil/trace.go:171","msg":"trace[80194729] linearizableReadLoop","detail":"{readStateIndex:6217; appliedIndex:6215; }","duration":"108.278795ms","start":"2026-06-16T11:48:08.08083Z","end":"2026-06-16T11:48:08.189109Z","steps":["trace[80194729] 'read index received' (duration: 97.937236ms)","trace[80194729] 'applied index is now lower than readState.Index' (duration: 10.339759ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T11:48:08.189332Z","caller":"traceutil/trace.go:171","msg":"trace[1923028092] transaction","detail":"{read_only:false; response_revision:5996; number_of_response:1; }","duration":"108.629001ms","start":"2026-06-16T11:48:08.080534Z","end":"2026-06-16T11:48:08.189162Z","steps":["trace[1923028092] 'process raft request' (duration: 108.418307ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:48:08.190221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.372677ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:57 size:2224963"} {"level":"info","ts":"2026-06-16T11:48:08.190277Z","caller":"traceutil/trace.go:171","msg":"trace[1385255887] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:57; response_revision:5996; }","duration":"109.489069ms","start":"2026-06-16T11:48:08.080773Z","end":"2026-06-16T11:48:08.190262Z","steps":["trace[1385255887] 'agreement among raft nodes before linearized reading' (duration: 108.464799ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:53:06.680314Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5986} {"level":"info","ts":"2026-06-16T11:53:06.774453Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5986,"took":"91.917653ms","hash":1499272778,"current-db-size-bytes":58159104,"current-db-size":"58 MB","current-db-size-in-use-bytes":21700608,"current-db-size-in-use":"22 MB"} {"level":"info","ts":"2026-06-16T11:53:06.77454Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1499272778,"revision":5986,"compact-revision":2947} {"level":"info","ts":"2026-06-16T11:53:35.038006Z","caller":"traceutil/trace.go:171","msg":"trace[601019920] transaction","detail":"{read_only:false; response_revision:8390; number_of_response:1; }","duration":"154.092868ms","start":"2026-06-16T11:53:34.883874Z","end":"2026-06-16T11:53:35.037967Z","steps":["trace[601019920] 'process raft request' (duration: 118.803546ms)","trace[601019920] 'compare' (duration: 34.836924ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T11:53:46.681194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.646117ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclients/\" range_end:\"/registry/ceph.rook.io/cephclients0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-16T11:53:46.681279Z","caller":"traceutil/trace.go:171","msg":"trace[2106342522] range","detail":"{range_begin:/registry/ceph.rook.io/cephclients/; range_end:/registry/ceph.rook.io/cephclients0; response_count:0; response_revision:8448; }","duration":"156.778399ms","start":"2026-06-16T11:53:46.524486Z","end":"2026-06-16T11:53:46.681264Z","steps":["trace[2106342522] 'count revisions from in-memory index tree' (duration: 156.563446ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:53:46.681264Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.573051ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephbuckettopics/\" range_end:\"/registry/ceph.rook.io/cephbuckettopics0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-16T11:53:46.681343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.746895ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephbuckettopics/\" range_end:\"/registry/ceph.rook.io/cephbuckettopics0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-16T11:53:46.681377Z","caller":"traceutil/trace.go:171","msg":"trace[1659963200] range","detail":"{range_begin:/registry/ceph.rook.io/cephbuckettopics/; range_end:/registry/ceph.rook.io/cephbuckettopics0; response_count:0; response_revision:8448; }","duration":"235.803006ms","start":"2026-06-16T11:53:46.445559Z","end":"2026-06-16T11:53:46.681362Z","steps":["trace[1659963200] 'range keys from in-memory index tree' (duration: 235.607933ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:53:46.681384Z","caller":"traceutil/trace.go:171","msg":"trace[1115204448] range","detail":"{range_begin:/registry/ceph.rook.io/cephbuckettopics/; range_end:/registry/ceph.rook.io/cephbuckettopics0; response_count:0; response_revision:8448; }","duration":"235.742595ms","start":"2026-06-16T11:53:46.445597Z","end":"2026-06-16T11:53:46.68134Z","steps":["trace[1115204448] 'count revisions from in-memory index tree' (duration: 235.48462ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:53:46.681429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.468331ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:559"} {"level":"warn","ts":"2026-06-16T11:53:46.681537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.917324ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephrbdmirrors/\" range_end:\"/registry/ceph.rook.io/cephrbdmirrors0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-16T11:53:46.681508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.508575ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclients/\" range_end:\"/registry/ceph.rook.io/cephclients0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-16T11:53:46.681583Z","caller":"traceutil/trace.go:171","msg":"trace[761008164] range","detail":"{range_begin:/registry/ceph.rook.io/cephrbdmirrors/; range_end:/registry/ceph.rook.io/cephrbdmirrors0; response_count:0; response_revision:8448; }","duration":"251.966225ms","start":"2026-06-16T11:53:46.429606Z","end":"2026-06-16T11:53:46.681572Z","steps":["trace[761008164] 'range keys from in-memory index tree' (duration: 251.827372ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:53:46.681599Z","caller":"traceutil/trace.go:171","msg":"trace[1375684209] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:8448; }","duration":"191.709906ms","start":"2026-06-16T11:53:46.48987Z","end":"2026-06-16T11:53:46.68158Z","steps":["trace[1375684209] 'range keys from in-memory index tree' (duration: 191.219836ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:53:46.681623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.384178ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephfilesystemsubvolumegroups/\" range_end:\"/registry/ceph.rook.io/cephfilesystemsubvolumegroups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-16T11:53:46.681687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.542592ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephcosidrivers/\" range_end:\"/registry/ceph.rook.io/cephcosidrivers0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-16T11:53:46.681691Z","caller":"traceutil/trace.go:171","msg":"trace[1595590647] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystemsubvolumegroups/; range_end:/registry/ceph.rook.io/cephfilesystemsubvolumegroups0; response_count:0; response_revision:8448; }","duration":"214.459839ms","start":"2026-06-16T11:53:46.46721Z","end":"2026-06-16T11:53:46.68167Z","steps":["trace[1595590647] 'count revisions from in-memory index tree' (duration: 214.257176ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:53:46.68172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.153449ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephrbdmirrors/\" range_end:\"/registry/ceph.rook.io/cephrbdmirrors0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-16T11:53:46.681733Z","caller":"traceutil/trace.go:171","msg":"trace[456862281] range","detail":"{range_begin:/registry/ceph.rook.io/cephcosidrivers/; range_end:/registry/ceph.rook.io/cephcosidrivers0; response_count:0; response_revision:8448; }","duration":"191.639035ms","start":"2026-06-16T11:53:46.490082Z","end":"2026-06-16T11:53:46.681721Z","steps":["trace[456862281] 'range keys from in-memory index tree' (duration: 191.44666ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:53:46.681765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.183839ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephrbdmirrors/\" range_end:\"/registry/ceph.rook.io/cephrbdmirrors0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-16T11:53:46.681785Z","caller":"traceutil/trace.go:171","msg":"trace[869505522] range","detail":"{range_begin:/registry/ceph.rook.io/cephrbdmirrors/; range_end:/registry/ceph.rook.io/cephrbdmirrors0; response_count:0; response_revision:8448; }","duration":"252.241291ms","start":"2026-06-16T11:53:46.429539Z","end":"2026-06-16T11:53:46.681781Z","steps":["trace[869505522] 'count revisions from in-memory index tree' (duration: 252.041906ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:53:46.681288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.072412ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephbuckettopics/\" range_end:\"/registry/ceph.rook.io/cephbuckettopics0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-16T11:53:46.681839Z","caller":"traceutil/trace.go:171","msg":"trace[152322125] range","detail":"{range_begin:/registry/ceph.rook.io/cephbuckettopics/; range_end:/registry/ceph.rook.io/cephbuckettopics0; response_count:0; response_revision:8448; }","duration":"235.670005ms","start":"2026-06-16T11:53:46.446158Z","end":"2026-06-16T11:53:46.681828Z","steps":["trace[152322125] 'range keys from in-memory index tree' (duration: 234.954911ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:53:46.681584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.355267ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephfilesystemsubvolumegroups/\" range_end:\"/registry/ceph.rook.io/cephfilesystemsubvolumegroups0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-16T11:53:46.681949Z","caller":"traceutil/trace.go:171","msg":"trace[497856021] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystemsubvolumegroups/; range_end:/registry/ceph.rook.io/cephfilesystemsubvolumegroups0; response_count:0; response_revision:8448; }","duration":"214.737496ms","start":"2026-06-16T11:53:46.467199Z","end":"2026-06-16T11:53:46.681936Z","steps":["trace[497856021] 'range keys from in-memory index tree' (duration: 214.228085ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:53:46.681488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.599913ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephfilesystemsubvolumegroups/\" range_end:\"/registry/ceph.rook.io/cephfilesystemsubvolumegroups0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-16T11:53:46.682007Z","caller":"traceutil/trace.go:171","msg":"trace[95513129] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystemsubvolumegroups/; range_end:/registry/ceph.rook.io/cephfilesystemsubvolumegroups0; response_count:0; response_revision:8448; }","duration":"214.156804ms","start":"2026-06-16T11:53:46.467839Z","end":"2026-06-16T11:53:46.681995Z","steps":["trace[95513129] 'range keys from in-memory index tree' (duration: 213.550321ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:53:46.681923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.44518ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephcosidrivers/\" range_end:\"/registry/ceph.rook.io/cephcosidrivers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-16T11:53:46.682059Z","caller":"traceutil/trace.go:171","msg":"trace[367196630] range","detail":"{range_begin:/registry/ceph.rook.io/cephcosidrivers/; range_end:/registry/ceph.rook.io/cephcosidrivers0; response_count:0; response_revision:8448; }","duration":"192.594503ms","start":"2026-06-16T11:53:46.489459Z","end":"2026-06-16T11:53:46.682053Z","steps":["trace[367196630] 'count revisions from in-memory index tree' (duration: 192.381249ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:53:46.68166Z","caller":"traceutil/trace.go:171","msg":"trace[802408738] range","detail":"{range_begin:/registry/ceph.rook.io/cephclients/; range_end:/registry/ceph.rook.io/cephclients0; response_count:0; response_revision:8448; }","duration":"156.735009ms","start":"2026-06-16T11:53:46.524874Z","end":"2026-06-16T11:53:46.681609Z","steps":["trace[802408738] 'range keys from in-memory index tree' (duration: 156.347701ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:53:46.682105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.913015ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/objectbucket.io/objectbucketclaims/\" range_end:\"/registry/objectbucket.io/objectbucketclaims0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-16T11:53:46.682119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.667043ms","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":"warn","ts":"2026-06-16T11:53:46.682221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.554249ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/objectbucket.io/objectbucketclaims/\" range_end:\"/registry/objectbucket.io/objectbucketclaims0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-16T11:53:46.682275Z","caller":"traceutil/trace.go:171","msg":"trace[1932635908] range","detail":"{range_begin:/registry/objectbucket.io/objectbucketclaims/; range_end:/registry/objectbucket.io/objectbucketclaims0; response_count:0; response_revision:8448; }","duration":"174.62409ms","start":"2026-06-16T11:53:46.507632Z","end":"2026-06-16T11:53:46.682256Z","steps":["trace[1932635908] 'range keys from in-memory index tree' (duration: 174.486677ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:53:46.682294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.81582ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclients/\" range_end:\"/registry/ceph.rook.io/cephclients0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-16T11:53:46.68233Z","caller":"traceutil/trace.go:171","msg":"trace[1638669733] range","detail":"{range_begin:/registry/ceph.rook.io/cephclients/; range_end:/registry/ceph.rook.io/cephclients0; response_count:0; response_revision:8448; }","duration":"157.874391ms","start":"2026-06-16T11:53:46.524443Z","end":"2026-06-16T11:53:46.682317Z","steps":["trace[1638669733] 'range keys from in-memory index tree' (duration: 157.747679ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:53:46.682334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.748917ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectzones/\" range_end:\"/registry/ceph.rook.io/cephobjectzones0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-16T11:53:46.682439Z","caller":"traceutil/trace.go:171","msg":"trace[2012160705] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectzones/; range_end:/registry/ceph.rook.io/cephobjectzones0; response_count:0; response_revision:8448; }","duration":"105.87658ms","start":"2026-06-16T11:53:46.576551Z","end":"2026-06-16T11:53:46.682427Z","steps":["trace[2012160705] 'range keys from in-memory index tree' (duration: 105.662506ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:53:46.682455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.204521ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/objectbucket.io/objectbucketclaims/\" range_end:\"/registry/objectbucket.io/objectbucketclaims0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-16T11:53:46.682475Z","caller":"traceutil/trace.go:171","msg":"trace[1404622937] range","detail":"{range_begin:/registry/objectbucket.io/objectbucketclaims/; range_end:/registry/objectbucket.io/objectbucketclaims0; response_count:0; response_revision:8448; }","duration":"175.251651ms","start":"2026-06-16T11:53:46.507217Z","end":"2026-06-16T11:53:46.682468Z","steps":["trace[1404622937] 'count revisions from in-memory index tree' (duration: 175.13077ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:53:46.682581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.196172ms","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-06-16T11:53:46.68263Z","caller":"traceutil/trace.go:171","msg":"trace[985276236] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectstores/; range_end:/registry/ceph.rook.io/cephobjectstores0; response_count:0; response_revision:8448; }","duration":"130.273834ms","start":"2026-06-16T11:53:46.552344Z","end":"2026-06-16T11:53:46.682618Z","steps":["trace[985276236] 'range keys from in-memory index tree' (duration: 130.144582ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:53:46.682651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.456011ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectzones/\" range_end:\"/registry/ceph.rook.io/cephobjectzones0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-16T11:53:46.682726Z","caller":"traceutil/trace.go:171","msg":"trace[232643944] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectzones/; range_end:/registry/ceph.rook.io/cephobjectzones0; response_count:0; response_revision:8448; }","duration":"104.577424ms","start":"2026-06-16T11:53:46.578123Z","end":"2026-06-16T11:53:46.6827Z","steps":["trace[232643944] 'range keys from in-memory index tree' (duration: 104.40716ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:53:46.682129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.456761ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephcosidrivers/\" range_end:\"/registry/ceph.rook.io/cephcosidrivers0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-16T11:53:46.681741Z","caller":"traceutil/trace.go:171","msg":"trace[1775042712] range","detail":"{range_begin:/registry/ceph.rook.io/cephrbdmirrors/; range_end:/registry/ceph.rook.io/cephrbdmirrors0; response_count:0; response_revision:8448; }","duration":"251.1764ms","start":"2026-06-16T11:53:46.430559Z","end":"2026-06-16T11:53:46.681735Z","steps":["trace[1775042712] 'range keys from in-memory index tree' (duration: 251.101137ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:53:46.682146Z","caller":"traceutil/trace.go:171","msg":"trace[1467565502] range","detail":"{range_begin:/registry/objectbucket.io/objectbucketclaims/; range_end:/registry/objectbucket.io/objectbucketclaims0; response_count:0; response_revision:8448; }","duration":"174.979856ms","start":"2026-06-16T11:53:46.507157Z","end":"2026-06-16T11:53:46.682137Z","steps":["trace[1467565502] 'range keys from in-memory index tree' (duration: 174.808203ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:53:46.683111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.680811ms","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":"info","ts":"2026-06-16T11:53:46.683341Z","caller":"traceutil/trace.go:171","msg":"trace[1358087296] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectstores/; range_end:/registry/ceph.rook.io/cephobjectstores0; response_count:0; response_revision:8448; }","duration":"131.958327ms","start":"2026-06-16T11:53:46.551371Z","end":"2026-06-16T11:53:46.68333Z","steps":["trace[1358087296] 'count revisions from in-memory index tree' (duration: 131.526127ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:53:46.682832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.963121ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectzones/\" range_end:\"/registry/ceph.rook.io/cephobjectzones0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-16T11:53:46.683499Z","caller":"traceutil/trace.go:171","msg":"trace[1023850221] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectzones/; range_end:/registry/ceph.rook.io/cephobjectzones0; response_count:0; response_revision:8448; }","duration":"106.845888ms","start":"2026-06-16T11:53:46.576644Z","end":"2026-06-16T11:53:46.68349Z","steps":["trace[1023850221] 'count revisions from in-memory index tree' (duration: 105.772267ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:53:46.683005Z","caller":"traceutil/trace.go:171","msg":"trace[874624888] range","detail":"{range_begin:/registry/ceph.rook.io/cephcosidrivers/; range_end:/registry/ceph.rook.io/cephcosidrivers0; response_count:0; response_revision:8448; }","duration":"193.377438ms","start":"2026-06-16T11:53:46.48961Z","end":"2026-06-16T11:53:46.682987Z","steps":["trace[874624888] 'range keys from in-memory index tree' (duration: 192.303328ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:53:46.683344Z","caller":"traceutil/trace.go:171","msg":"trace[1417989523] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectstores/; range_end:/registry/ceph.rook.io/cephobjectstores0; response_count:0; response_revision:8448; }","duration":"130.790204ms","start":"2026-06-16T11:53:46.551389Z","end":"2026-06-16T11:53:46.682179Z","steps":["trace[1417989523] 'range keys from in-memory index tree' (duration: 130.537268ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:53:47.702835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.07568ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-06-16T11:53:47.702937Z","caller":"traceutil/trace.go:171","msg":"trace[2131775884] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8455; }","duration":"120.237083ms","start":"2026-06-16T11:53:47.582677Z","end":"2026-06-16T11:53:47.702914Z","steps":["trace[2131775884] 'range keys from in-memory index tree' (duration: 119.827405ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:53:47.70294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.051047ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-06-16T11:53:47.703075Z","caller":"traceutil/trace.go:171","msg":"trace[881917701] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8455; }","duration":"122.258861ms","start":"2026-06-16T11:53:47.580791Z","end":"2026-06-16T11:53:47.70305Z","steps":["trace[881917701] 'range keys from in-memory index tree' (duration: 121.834493ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:54:16.669797Z","caller":"traceutil/trace.go:171","msg":"trace[2106551788] transaction","detail":"{read_only:false; response_revision:8666; number_of_response:1; }","duration":"158.338079ms","start":"2026-06-16T11:54:16.511433Z","end":"2026-06-16T11:54:16.669771Z","steps":["trace[2106551788] 'process raft request' (duration: 158.171186ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:54:17.06343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.487192ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-16T11:54:17.063581Z","caller":"traceutil/trace.go:171","msg":"trace[1378428891] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:8666; }","duration":"105.652555ms","start":"2026-06-16T11:54:16.957903Z","end":"2026-06-16T11:54:17.063556Z","steps":["trace[1378428891] 'range keys from in-memory index tree' (duration: 105.462911ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:54:17.063622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.552239ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:559"} {"level":"info","ts":"2026-06-16T11:54:17.06371Z","caller":"traceutil/trace.go:171","msg":"trace[1102286377] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:8666; }","duration":"345.651351ms","start":"2026-06-16T11:54:16.718002Z","end":"2026-06-16T11:54:17.063653Z","steps":["trace[1102286377] 'range keys from in-memory index tree' (duration: 345.382696ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:54:17.063754Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T11:54:16.717983Z","time spent":"345.759093ms","remote":"127.0.0.1:32838","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":583,"request content":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" "} {"level":"warn","ts":"2026-06-16T11:54:17.063865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.232058ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/barbican-api-d6f797747-xfnlz.18b98d96e661bddc\" ","response":"range_response_count:1 size:1132"} {"level":"info","ts":"2026-06-16T11:54:17.064014Z","caller":"traceutil/trace.go:171","msg":"trace[262994550] range","detail":"{range_begin:/registry/events/openstack/barbican-api-d6f797747-xfnlz.18b98d96e661bddc; range_end:; response_count:1; response_revision:8666; }","duration":"211.396501ms","start":"2026-06-16T11:54:16.852587Z","end":"2026-06-16T11:54:17.063984Z","steps":["trace[262994550] 'range keys from in-memory index tree' (duration: 210.932552ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:54:17.076707Z","caller":"traceutil/trace.go:171","msg":"trace[463118187] transaction","detail":"{read_only:false; response_revision:8667; number_of_response:1; }","duration":"157.938692ms","start":"2026-06-16T11:54:16.91874Z","end":"2026-06-16T11:54:17.076678Z","steps":["trace[463118187] 'process raft request' (duration: 157.755688ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:54:17.085646Z","caller":"traceutil/trace.go:171","msg":"trace[1829707253] linearizableReadLoop","detail":"{readStateIndex:8980; appliedIndex:8978; }","duration":"113.150216ms","start":"2026-06-16T11:54:16.972458Z","end":"2026-06-16T11:54:17.085608Z","steps":["trace[1829707253] 'read index received' (duration: 104.061934ms)","trace[1829707253] 'applied index is now lower than readState.Index' (duration: 9.086752ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T11:54:17.086095Z","caller":"traceutil/trace.go:171","msg":"trace[609986657] transaction","detail":"{read_only:false; response_revision:8668; number_of_response:1; }","duration":"155.846012ms","start":"2026-06-16T11:54:16.930214Z","end":"2026-06-16T11:54:17.08606Z","steps":["trace[609986657] 'process raft request' (duration: 155.004675ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:54:17.086967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.482861ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-52fr8\" ","response":"range_response_count:1 size:6451"} {"level":"info","ts":"2026-06-16T11:54:17.087059Z","caller":"traceutil/trace.go:171","msg":"trace[740494977] range","detail":"{range_begin:/registry/pods/openstack/keepalived-52fr8; range_end:; response_count:1; response_revision:8669; }","duration":"114.615845ms","start":"2026-06-16T11:54:16.972405Z","end":"2026-06-16T11:54:17.087021Z","steps":["trace[740494977] 'agreement among raft nodes before linearized reading' (duration: 113.354261ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:54:19.992866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.065691ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-16T11:54:19.993011Z","caller":"traceutil/trace.go:171","msg":"trace[305705295] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:8684; }","duration":"118.265055ms","start":"2026-06-16T11:54:19.87471Z","end":"2026-06-16T11:54:19.992975Z","steps":["trace[305705295] 'count revisions from in-memory index tree' (duration: 117.957649ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:54:29.772363Z","caller":"traceutil/trace.go:171","msg":"trace[846999318] transaction","detail":"{read_only:false; response_revision:8779; number_of_response:1; }","duration":"171.747964ms","start":"2026-06-16T11:54:29.600563Z","end":"2026-06-16T11:54:29.772311Z","steps":["trace[846999318] 'process raft request' (duration: 171.155603ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T11:54:29.986639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.525297ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-16T11:54:29.987089Z","caller":"traceutil/trace.go:171","msg":"trace[1693794543] transaction","detail":"{read_only:false; response_revision:8780; number_of_response:1; }","duration":"209.22545ms","start":"2026-06-16T11:54:29.777777Z","end":"2026-06-16T11:54:29.987002Z","steps":["trace[1693794543] 'process raft request' (duration: 76.200463ms)","trace[1693794543] 'compare' (duration: 132.365944ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T11:54:47.118389Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-000000000000242f.wal"} {"level":"warn","ts":"2026-06-16T11:55:47.984688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.376319ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/challenges/\" range_end:\"/registry/acme.cert-manager.io/challenges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-16T11:55:47.984858Z","caller":"traceutil/trace.go:171","msg":"trace[280448457] range","detail":"{range_begin:/registry/acme.cert-manager.io/challenges/; range_end:/registry/acme.cert-manager.io/challenges0; response_count:0; response_revision:9538; }","duration":"201.641684ms","start":"2026-06-16T11:55:47.783192Z","end":"2026-06-16T11:55:47.984834Z","steps":["trace[280448457] 'count revisions from in-memory index tree' (duration: 201.243617ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T11:55:47.984981Z","caller":"traceutil/trace.go:171","msg":"trace[40652307] transaction","detail":"{read_only:false; response_revision:9539; number_of_response:1; }","duration":"154.527215ms","start":"2026-06-16T11:55:47.830401Z","end":"2026-06-16T11:55:47.984929Z","steps":["trace[40652307] 'process raft request' (duration: 139.587831ms)","trace[40652307] 'compare' (duration: 14.449355ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T11:56:01.174327Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"d7dbc9f5893cc1f6","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-16T11:56:01.181786Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-06-16T11:56:01.181915Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-06-16T11:58:06.687204Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8063} {"level":"info","ts":"2026-06-16T11:58:06.752168Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8063,"took":"62.061738ms","hash":3431302120,"current-db-size-bytes":58159104,"current-db-size":"58 MB","current-db-size-in-use-bytes":28553216,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-06-16T11:58:06.752239Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3431302120,"revision":8063,"compact-revision":5986} {"level":"info","ts":"2026-06-16T12:01:32.628909Z","caller":"traceutil/trace.go:171","msg":"trace[1709563216] linearizableReadLoop","detail":"{readStateIndex:12457; appliedIndex:12456; }","duration":"190.489358ms","start":"2026-06-16T12:01:32.438387Z","end":"2026-06-16T12:01:32.628877Z","steps":["trace[1709563216] 'read index received' (duration: 190.303024ms)","trace[1709563216] 'applied index is now lower than readState.Index' (duration: 184.934µs)"],"step_count":2} {"level":"info","ts":"2026-06-16T12:01:32.629004Z","caller":"traceutil/trace.go:171","msg":"trace[2077926127] transaction","detail":"{read_only:false; response_revision:12037; number_of_response:1; }","duration":"192.333762ms","start":"2026-06-16T12:01:32.43661Z","end":"2026-06-16T12:01:32.628944Z","steps":["trace[2077926127] 'process raft request' (duration: 192.008276ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T12:01:32.629662Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.227892ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:49 size:452196"} {"level":"info","ts":"2026-06-16T12:01:32.629715Z","caller":"traceutil/trace.go:171","msg":"trace[831865606] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:49; response_revision:12037; }","duration":"191.338434ms","start":"2026-06-16T12:01:32.438363Z","end":"2026-06-16T12:01:32.629702Z","steps":["trace[831865606] 'agreement among raft nodes before linearized reading' (duration: 190.672111ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T12:01:32.767744Z","caller":"traceutil/trace.go:171","msg":"trace[362105157] transaction","detail":"{read_only:false; response_revision:12038; number_of_response:1; }","duration":"304.740773ms","start":"2026-06-16T12:01:32.462975Z","end":"2026-06-16T12:01:32.767716Z","steps":["trace[362105157] 'process raft request' (duration: 303.226024ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T12:01:32.767907Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T12:01:32.462961Z","time spent":"304.860885ms","remote":"127.0.0.1:32838","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-16T12:01:32.76805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.5377ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"warn","ts":"2026-06-16T12:01:32.768051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.492982ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-06-16T12:01:32.768121Z","caller":"traceutil/trace.go:171","msg":"trace[267232569] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:12038; }","duration":"292.622223ms","start":"2026-06-16T12:01:32.475482Z","end":"2026-06-16T12:01:32.768105Z","steps":["trace[267232569] 'agreement among raft nodes before linearized reading' (duration: 292.326136ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T12:01:32.768128Z","caller":"traceutil/trace.go:171","msg":"trace[336120166] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:12038; }","duration":"290.624415ms","start":"2026-06-16T12:01:32.477488Z","end":"2026-06-16T12:01:32.768112Z","steps":["trace[336120166] 'agreement among raft nodes before linearized reading' (duration: 290.319228ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T12:01:32.767734Z","caller":"traceutil/trace.go:171","msg":"trace[1106898932] linearizableReadLoop","detail":"{readStateIndex:12458; appliedIndex:12457; }","duration":"138.695051ms","start":"2026-06-16T12:01:32.628998Z","end":"2026-06-16T12:01:32.767693Z","steps":["trace[1106898932] 'read index received' (duration: 137.242904ms)","trace[1106898932] 'applied index is now lower than readState.Index' (duration: 1.449817ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T12:01:32.942717Z","caller":"traceutil/trace.go:171","msg":"trace[387151986] transaction","detail":"{read_only:false; response_revision:12043; number_of_response:1; }","duration":"129.079558ms","start":"2026-06-16T12:01:32.8136Z","end":"2026-06-16T12:01:32.94268Z","steps":["trace[387151986] 'process raft request' (duration: 128.868464ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T12:01:32.948585Z","caller":"traceutil/trace.go:171","msg":"trace[1131548031] transaction","detail":"{read_only:false; response_revision:12044; number_of_response:1; }","duration":"130.094758ms","start":"2026-06-16T12:01:32.818466Z","end":"2026-06-16T12:01:32.948561Z","steps":["trace[1131548031] 'process raft request' (duration: 129.998795ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T12:03:06.694436Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10473} {"level":"info","ts":"2026-06-16T12:03:06.779914Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10473,"took":"81.935431ms","hash":3492292494,"current-db-size-bytes":58159104,"current-db-size":"58 MB","current-db-size-in-use-bytes":26292224,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-06-16T12:03:06.780019Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3492292494,"revision":10473,"compact-revision":8063} {"level":"info","ts":"2026-06-16T12:08:06.702793Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12670} {"level":"info","ts":"2026-06-16T12:08:06.780224Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12670,"took":"74.40254ms","hash":229076673,"current-db-size-bytes":58159104,"current-db-size":"58 MB","current-db-size-in-use-bytes":27258880,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-06-16T12:08:06.780307Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":229076673,"revision":12670,"compact-revision":10473} {"level":"info","ts":"2026-06-16T12:08:11.183708Z","caller":"traceutil/trace.go:171","msg":"trace[852613328] transaction","detail":"{read_only:false; response_revision:14734; number_of_response:1; }","duration":"187.977502ms","start":"2026-06-16T12:08:10.995703Z","end":"2026-06-16T12:08:11.183681Z","steps":["trace[852613328] 'process raft request' (duration: 187.806309ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T12:08:11.335894Z","caller":"traceutil/trace.go:171","msg":"trace[1635242028] linearizableReadLoop","detail":"{readStateIndex:15250; appliedIndex:15249; }","duration":"110.134097ms","start":"2026-06-16T12:08:11.22573Z","end":"2026-06-16T12:08:11.335864Z","steps":["trace[1635242028] 'read index received' (duration: 32.443395ms)","trace[1635242028] 'applied index is now lower than readState.Index' (duration: 77.684372ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T12:08:11.335928Z","caller":"traceutil/trace.go:171","msg":"trace[330186769] transaction","detail":"{read_only:false; response_revision:14735; number_of_response:1; }","duration":"337.234961ms","start":"2026-06-16T12:08:10.998591Z","end":"2026-06-16T12:08:11.335826Z","steps":["trace[330186769] 'process raft request' (duration: 259.62366ms)","trace[330186769] 'compare' (duration: 77.016169ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T12:08:11.336262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.272213ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-16T12:08:11.336328Z","caller":"traceutil/trace.go:171","msg":"trace[383915168] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:14736; }","duration":"107.366944ms","start":"2026-06-16T12:08:11.22894Z","end":"2026-06-16T12:08:11.336307Z","steps":["trace[383915168] 'agreement among raft nodes before linearized reading' (duration: 107.162121ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T12:08:11.336332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.572035ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-06-16T12:08:11.336372Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T12:08:10.99856Z","time spent":"337.490246ms","remote":"127.0.0.1:32838","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T12:08:11.336434Z","caller":"traceutil/trace.go:171","msg":"trace[949217602] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:14736; }","duration":"110.744748ms","start":"2026-06-16T12:08:11.225665Z","end":"2026-06-16T12:08:11.33641Z","steps":["trace[949217602] 'agreement among raft nodes before linearized reading' (duration: 110.414462ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T12:08:34.548341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.275758ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-d7ba7bf1-dfc3-4c88-92a5-3ad658bd3cd8\" ","response":"range_response_count:1 size:3637"} {"level":"info","ts":"2026-06-16T12:08:34.548491Z","caller":"traceutil/trace.go:171","msg":"trace[125525125] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-d7ba7bf1-dfc3-4c88-92a5-3ad658bd3cd8; range_end:; response_count:1; response_revision:15048; }","duration":"140.555704ms","start":"2026-06-16T12:08:34.407908Z","end":"2026-06-16T12:08:34.548463Z","steps":["trace[125525125] 'range keys from in-memory index tree' (duration: 139.918942ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T12:08:34.894816Z","caller":"traceutil/trace.go:171","msg":"trace[2079771117] transaction","detail":"{read_only:false; response_revision:15052; number_of_response:1; }","duration":"338.139938ms","start":"2026-06-16T12:08:34.556645Z","end":"2026-06-16T12:08:34.894785Z","steps":["trace[2079771117] 'process raft request' (duration: 337.943354ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T12:08:34.895172Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T12:08:34.556625Z","time spent":"338.377973ms","remote":"127.0.0.1:60970","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3742,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T12:08:34.898321Z","caller":"traceutil/trace.go:171","msg":"trace[1997798917] transaction","detail":"{read_only:false; response_revision:15053; number_of_response:1; }","duration":"139.104435ms","start":"2026-06-16T12:08:34.759159Z","end":"2026-06-16T12:08:34.898263Z","steps":["trace[1997798917] 'process raft request' (duration: 138.79126ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T12:09:27.624212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.860358ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/permissions/\" range_end:\"/registry/rabbitmq.com/permissions0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-16T12:09:27.624312Z","caller":"traceutil/trace.go:171","msg":"trace[2068298783] range","detail":"{range_begin:/registry/rabbitmq.com/permissions/; range_end:/registry/rabbitmq.com/permissions0; response_count:0; response_revision:15686; }","duration":"122.993711ms","start":"2026-06-16T12:09:27.5013Z","end":"2026-06-16T12:09:27.624293Z","steps":["trace[2068298783] 'count revisions from in-memory index tree' (duration: 122.810266ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T12:09:51.564454Z","caller":"traceutil/trace.go:171","msg":"trace[634347680] transaction","detail":"{read_only:false; response_revision:15815; number_of_response:1; }","duration":"165.318733ms","start":"2026-06-16T12:09:51.399095Z","end":"2026-06-16T12:09:51.564414Z","steps":["trace[634347680] 'process raft request' (duration: 165.010788ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T12:13:06.80085Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14696} {"level":"info","ts":"2026-06-16T12:13:07.0005Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14696,"took":"197.232298ms","hash":552768924,"current-db-size-bytes":58159104,"current-db-size":"58 MB","current-db-size-in-use-bytes":34177024,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-06-16T12:13:07.00059Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":552768924,"revision":14696,"compact-revision":12670} {"level":"info","ts":"2026-06-16T12:16:03.451781Z","caller":"traceutil/trace.go:171","msg":"trace[665570202] linearizableReadLoop","detail":"{readStateIndex:19156; appliedIndex:19155; }","duration":"127.761041ms","start":"2026-06-16T12:16:03.323986Z","end":"2026-06-16T12:16:03.451747Z","steps":["trace[665570202] 'read index received' (duration: 127.498696ms)","trace[665570202] 'applied index is now lower than readState.Index' (duration: 261.615µs)"],"step_count":2} {"level":"info","ts":"2026-06-16T12:16:03.451956Z","caller":"traceutil/trace.go:171","msg":"trace[1046985] transaction","detail":"{read_only:false; response_revision:18516; number_of_response:1; }","duration":"139.784748ms","start":"2026-06-16T12:16:03.312109Z","end":"2026-06-16T12:16:03.451894Z","steps":["trace[1046985] 'process raft request' (duration: 139.464203ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T12:16:03.452027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.023185ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-16T12:16:03.452064Z","caller":"traceutil/trace.go:171","msg":"trace[1359457618] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:18516; }","duration":"128.164859ms","start":"2026-06-16T12:16:03.323888Z","end":"2026-06-16T12:16:03.452053Z","steps":["trace[1359457618] 'agreement among raft nodes before linearized reading' (duration: 127.996485ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T12:16:03.75069Z","caller":"traceutil/trace.go:171","msg":"trace[235702838] linearizableReadLoop","detail":"{readStateIndex:19157; appliedIndex:19156; }","duration":"270.468275ms","start":"2026-06-16T12:16:03.48019Z","end":"2026-06-16T12:16:03.750659Z","steps":["trace[235702838] 'read index received' (duration: 270.270401ms)","trace[235702838] 'applied index is now lower than readState.Index' (duration: 196.594µs)"],"step_count":2} {"level":"info","ts":"2026-06-16T12:16:03.750789Z","caller":"traceutil/trace.go:171","msg":"trace[898663141] transaction","detail":"{read_only:false; response_revision:18517; number_of_response:1; }","duration":"282.31278ms","start":"2026-06-16T12:16:03.468416Z","end":"2026-06-16T12:16:03.750729Z","steps":["trace[898663141] 'process raft request' (duration: 282.046535ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T12:16:03.751103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.858683ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-06-16T12:16:03.751201Z","caller":"traceutil/trace.go:171","msg":"trace[1572731885] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:18517; }","duration":"271.050657ms","start":"2026-06-16T12:16:03.480129Z","end":"2026-06-16T12:16:03.75118Z","steps":["trace[1572731885] 'agreement among raft nodes before linearized reading' (duration: 270.69549ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T12:17:20.041879Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"d7dbc9f5893cc1f6","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-16T12:17:20.04828Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-06-16T12:17:20.048418Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-06-16T12:18:06.843671Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17351} {"level":"info","ts":"2026-06-16T12:18:06.95087Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17351,"took":"102.471183ms","hash":949932649,"current-db-size-bytes":58159104,"current-db-size":"58 MB","current-db-size-in-use-bytes":35008512,"current-db-size-in-use":"35 MB"} {"level":"info","ts":"2026-06-16T12:18:06.950945Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":949932649,"revision":17351,"compact-revision":14696} {"level":"info","ts":"2026-06-16T12:21:50.173869Z","caller":"traceutil/trace.go:171","msg":"trace[1382835417] transaction","detail":"{read_only:false; response_revision:21217; number_of_response:1; }","duration":"138.435877ms","start":"2026-06-16T12:21:50.035391Z","end":"2026-06-16T12:21:50.173827Z","steps":["trace[1382835417] 'process raft request' (duration: 138.215723ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T12:21:50.257031Z","caller":"traceutil/trace.go:171","msg":"trace[2099474747] transaction","detail":"{read_only:false; response_revision:21219; number_of_response:1; }","duration":"220.660274ms","start":"2026-06-16T12:21:50.036349Z","end":"2026-06-16T12:21:50.257009Z","steps":["trace[2099474747] 'process raft request' (duration: 220.611423ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T12:21:50.257475Z","caller":"traceutil/trace.go:171","msg":"trace[1224814626] transaction","detail":"{read_only:false; response_revision:21218; number_of_response:1; }","duration":"221.997238ms","start":"2026-06-16T12:21:50.035466Z","end":"2026-06-16T12:21:50.257464Z","steps":["trace[1224814626] 'process raft request' (duration: 221.306416ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T12:22:06.05149Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.99268ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:30"} {"level":"info","ts":"2026-06-16T12:22:06.507556Z","caller":"traceutil/trace.go:171","msg":"trace[1079779350] linearizableReadLoop","detail":"{readStateIndex:22038; appliedIndex:22037; }","duration":"182.418484ms","start":"2026-06-16T12:22:06.32511Z","end":"2026-06-16T12:22:06.507529Z","steps":["trace[1079779350] 'read index received' (duration: 182.241841ms)","trace[1079779350] 'applied index is now lower than readState.Index' (duration: 175.513µs)"],"step_count":2} {"level":"info","ts":"2026-06-16T12:22:06.507917Z","caller":"traceutil/trace.go:171","msg":"trace[1626053828] transaction","detail":"{read_only:false; response_revision:21302; number_of_response:1; }","duration":"243.244442ms","start":"2026-06-16T12:22:06.264659Z","end":"2026-06-16T12:22:06.507903Z","steps":["trace[1626053828] 'process raft request' (duration: 242.666992ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T12:22:06.508233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.110078ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-16T12:22:06.5084Z","caller":"traceutil/trace.go:171","msg":"trace[1062003415] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:21302; }","duration":"183.340572ms","start":"2026-06-16T12:22:06.325043Z","end":"2026-06-16T12:22:06.508384Z","steps":["trace[1062003415] 'agreement among raft nodes before linearized reading' (duration: 183.128488ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T12:22:06.64189Z","caller":"traceutil/trace.go:171","msg":"trace[970395094] linearizableReadLoop","detail":"{readStateIndex:22039; appliedIndex:22038; }","duration":"134.219687ms","start":"2026-06-16T12:22:06.507637Z","end":"2026-06-16T12:22:06.641856Z","steps":["trace[970395094] 'read index received' (duration: 51.716376ms)","trace[970395094] 'applied index is now lower than readState.Index' (duration: 82.502141ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T12:22:06.642039Z","caller":"traceutil/trace.go:171","msg":"trace[1629747612] transaction","detail":"{read_only:false; response_revision:21303; number_of_response:1; }","duration":"278.083806ms","start":"2026-06-16T12:22:06.363888Z","end":"2026-06-16T12:22:06.641972Z","steps":["trace[1629747612] 'process raft request' (duration: 195.563104ms)","trace[1629747612] 'compare' (duration: 82.205886ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T12:22:06.642242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.840422ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"warn","ts":"2026-06-16T12:22:06.642246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.498449ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/\" range_end:\"/registry/cert-manager.io/certificates0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-16T12:22:06.642294Z","caller":"traceutil/trace.go:171","msg":"trace[1132801812] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:21303; }","duration":"286.940006ms","start":"2026-06-16T12:22:06.355342Z","end":"2026-06-16T12:22:06.642282Z","steps":["trace[1132801812] 'agreement among raft nodes before linearized reading' (duration: 286.672721ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T12:22:06.642264Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.520952ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-16T12:22:06.64235Z","caller":"traceutil/trace.go:171","msg":"trace[984522285] range","detail":"{range_begin:/registry/cert-manager.io/certificates/; range_end:/registry/cert-manager.io/certificates0; response_count:0; response_revision:21303; }","duration":"126.630591ms","start":"2026-06-16T12:22:06.515695Z","end":"2026-06-16T12:22:06.642325Z","steps":["trace[984522285] 'agreement among raft nodes before linearized reading' (duration: 126.361557ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T12:22:06.642384Z","caller":"traceutil/trace.go:171","msg":"trace[1078048168] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:21303; }","duration":"292.681474ms","start":"2026-06-16T12:22:06.349687Z","end":"2026-06-16T12:22:06.642369Z","steps":["trace[1078048168] 'agreement among raft nodes before linearized reading' (duration: 292.394489ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T12:22:06.80994Z","caller":"traceutil/trace.go:171","msg":"trace[232048894] transaction","detail":"{read_only:false; response_revision:21305; number_of_response:1; }","duration":"161.572537ms","start":"2026-06-16T12:22:06.648327Z","end":"2026-06-16T12:22:06.809899Z","steps":["trace[232048894] 'process raft request' (duration: 146.52031ms)","trace[232048894] 'compare' (duration: 14.906534ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T12:23:06.849917Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19696} {"level":"info","ts":"2026-06-16T12:23:06.959927Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19696,"took":"105.628092ms","hash":3954022253,"current-db-size-bytes":58159104,"current-db-size":"58 MB","current-db-size-in-use-bytes":29777920,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-06-16T12:23:06.960047Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3954022253,"revision":19696,"compact-revision":17351} {"level":"info","ts":"2026-06-16T12:28:06.855234Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":21884} {"level":"info","ts":"2026-06-16T12:28:07.060213Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":21884,"took":"199.188783ms","hash":3794460127,"current-db-size-bytes":58580992,"current-db-size":"59 MB","current-db-size-in-use-bytes":44056576,"current-db-size-in-use":"44 MB"} {"level":"info","ts":"2026-06-16T12:28:07.060316Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3794460127,"revision":21884,"compact-revision":19696} {"level":"info","ts":"2026-06-16T12:29:57.63386Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-00000000000068af.wal"} {"level":"info","ts":"2026-06-16T12:30:03.848656Z","caller":"traceutil/trace.go:171","msg":"trace[97671314] transaction","detail":"{read_only:false; response_revision:26102; number_of_response:1; }","duration":"105.51814ms","start":"2026-06-16T12:30:03.743106Z","end":"2026-06-16T12:30:03.848624Z","steps":["trace[97671314] 'process raft request' (duration: 105.327266ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T12:30:04.073509Z","caller":"traceutil/trace.go:171","msg":"trace[1509142321] linearizableReadLoop","detail":"{readStateIndex:26976; appliedIndex:26974; }","duration":"251.362477ms","start":"2026-06-16T12:30:03.822106Z","end":"2026-06-16T12:30:04.073469Z","steps":["trace[1509142321] 'read index received' (duration: 27.155887ms)","trace[1509142321] 'applied index is now lower than readState.Index' (duration: 224.20535ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T12:30:04.073632Z","caller":"traceutil/trace.go:171","msg":"trace[993679647] transaction","detail":"{read_only:false; response_revision:26104; number_of_response:1; }","duration":"297.673049ms","start":"2026-06-16T12:30:03.775903Z","end":"2026-06-16T12:30:04.073576Z","steps":["trace[993679647] 'process raft request' (duration: 297.508766ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T12:30:04.073583Z","caller":"traceutil/trace.go:171","msg":"trace[419632732] transaction","detail":"{read_only:false; response_revision:26103; number_of_response:1; }","duration":"313.940669ms","start":"2026-06-16T12:30:03.759589Z","end":"2026-06-16T12:30:04.073529Z","steps":["trace[419632732] 'process raft request' (duration: 313.626313ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T12:30:04.074143Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T12:30:03.759548Z","time spent":"314.413498ms","remote":"127.0.0.1:32838","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-16T12:30:04.074254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.103641ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/clusterissuers/\" range_end:\"/registry/cert-manager.io/clusterissuers0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-16T12:30:04.074362Z","caller":"traceutil/trace.go:171","msg":"trace[1590736166] range","detail":"{range_begin:/registry/cert-manager.io/clusterissuers/; range_end:/registry/cert-manager.io/clusterissuers0; response_count:0; response_revision:26104; }","duration":"252.292145ms","start":"2026-06-16T12:30:03.822045Z","end":"2026-06-16T12:30:04.074337Z","steps":["trace[1590736166] 'agreement among raft nodes before linearized reading' (duration: 251.55947ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T12:30:04.080575Z","caller":"traceutil/trace.go:171","msg":"trace[949580509] transaction","detail":"{read_only:false; response_revision:26105; number_of_response:1; }","duration":"169.08822ms","start":"2026-06-16T12:30:03.91147Z","end":"2026-06-16T12:30:04.080559Z","steps":["trace[949580509] 'process raft request' (duration: 168.949307ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T12:30:04.080713Z","caller":"traceutil/trace.go:171","msg":"trace[1768145869] transaction","detail":"{read_only:false; response_revision:26106; number_of_response:1; }","duration":"165.679224ms","start":"2026-06-16T12:30:03.915028Z","end":"2026-06-16T12:30:04.080707Z","steps":["trace[1768145869] 'process raft request' (duration: 165.501571ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T12:30:08.62359Z","caller":"traceutil/trace.go:171","msg":"trace[987571355] linearizableReadLoop","detail":"{readStateIndex:27024; appliedIndex:27023; }","duration":"101.050674ms","start":"2026-06-16T12:30:08.522488Z","end":"2026-06-16T12:30:08.623539Z","steps":["trace[987571355] 'read index received' (duration: 100.884101ms)","trace[987571355] 'applied index is now lower than readState.Index' (duration: 165.173µs)"],"step_count":2} {"level":"info","ts":"2026-06-16T12:30:08.623733Z","caller":"traceutil/trace.go:171","msg":"trace[1232970185] transaction","detail":"{read_only:false; response_revision:26150; number_of_response:1; }","duration":"104.077762ms","start":"2026-06-16T12:30:08.519603Z","end":"2026-06-16T12:30:08.623681Z","steps":["trace[1232970185] 'process raft request' (duration: 103.783716ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T12:30:08.623993Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.433622ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-06-16T12:30:08.624112Z","caller":"traceutil/trace.go:171","msg":"trace[931109067] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26150; }","duration":"101.607485ms","start":"2026-06-16T12:30:08.522473Z","end":"2026-06-16T12:30:08.62408Z","steps":["trace[931109067] 'agreement among raft nodes before linearized reading' (duration: 101.208368ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T12:30:08.985535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.690029ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-16T12:30:08.985867Z","caller":"traceutil/trace.go:171","msg":"trace[265439083] linearizableReadLoop","detail":"{readStateIndex:27026; appliedIndex:27024; }","duration":"340.673308ms","start":"2026-06-16T12:30:08.64517Z","end":"2026-06-16T12:30:08.985843Z","steps":["trace[265439083] 'read index received' (duration: 147.55153ms)","trace[265439083] 'applied index is now lower than readState.Index' (duration: 193.120338ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T12:30:08.985911Z","caller":"traceutil/trace.go:171","msg":"trace[446848145] transaction","detail":"{read_only:false; response_revision:26152; number_of_response:1; }","duration":"349.515536ms","start":"2026-06-16T12:30:08.636354Z","end":"2026-06-16T12:30:08.985869Z","steps":["trace[446848145] 'process raft request' (duration: 349.376164ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T12:30:08.98596Z","caller":"traceutil/trace.go:171","msg":"trace[165751428] transaction","detail":"{read_only:false; response_revision:26151; number_of_response:1; }","duration":"357.393656ms","start":"2026-06-16T12:30:08.628552Z","end":"2026-06-16T12:30:08.985946Z","steps":["trace[165751428] 'process raft request' (duration: 164.172156ms)","trace[165751428] 'compare' (duration: 192.351443ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T12:30:08.985974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.798891ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectzonegroups/\" range_end:\"/registry/ceph.rook.io/cephobjectzonegroups0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-16T12:30:08.986037Z","caller":"traceutil/trace.go:171","msg":"trace[2137967488] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectzonegroups/; range_end:/registry/ceph.rook.io/cephobjectzonegroups0; response_count:0; response_revision:26152; }","duration":"340.899952ms","start":"2026-06-16T12:30:08.645122Z","end":"2026-06-16T12:30:08.986022Z","steps":["trace[2137967488] 'agreement among raft nodes before linearized reading' (duration: 340.77698ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T12:30:08.986042Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T12:30:08.628519Z","time spent":"357.478268ms","remote":"127.0.0.1:32838","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-16T12:30:08.986068Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T12:30:08.636322Z","time spent":"349.655689ms","remote":"127.0.0.1:32838","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-16T12:30:08.986086Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T12:30:08.645109Z","time spent":"340.965484ms","remote":"127.0.0.1:43694","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":30,"request content":"key:\"/registry/ceph.rook.io/cephobjectzonegroups/\" range_end:\"/registry/ceph.rook.io/cephobjectzonegroups0\" count_only:true "} {"level":"warn","ts":"2026-06-16T12:30:09.398193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.389904ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-16T12:30:09.398295Z","caller":"traceutil/trace.go:171","msg":"trace[181574238] linearizableReadLoop","detail":"{readStateIndex:27027; appliedIndex:27026; }","duration":"412.374493ms","start":"2026-06-16T12:30:08.985904Z","end":"2026-06-16T12:30:09.398278Z","steps":["trace[181574238] 'read index received' (duration: 125.699144ms)","trace[181574238] 'applied index is now lower than readState.Index' (duration: 286.673809ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T12:30:09.398462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"433.394933ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" ","response":"range_response_count:1 size:1991"} {"level":"info","ts":"2026-06-16T12:30:09.398413Z","caller":"traceutil/trace.go:171","msg":"trace[1536750098] transaction","detail":"{read_only:false; response_revision:26153; number_of_response:1; }","duration":"457.315919ms","start":"2026-06-16T12:30:08.940997Z","end":"2026-06-16T12:30:09.398313Z","steps":["trace[1536750098] 'process raft request' (duration: 170.710861ms)","trace[1536750098] 'compare' (duration: 285.787093ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T12:30:09.398493Z","caller":"traceutil/trace.go:171","msg":"trace[687608694] range","detail":"{range_begin:/registry/services/specs/ingress-nginx/ingress-nginx-controller; range_end:; response_count:1; response_revision:26153; }","duration":"433.464395ms","start":"2026-06-16T12:30:08.965015Z","end":"2026-06-16T12:30:09.39848Z","steps":["trace[687608694] 'agreement among raft nodes before linearized reading' (duration: 433.345763ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T12:30:09.398518Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T12:30:08.96499Z","time spent":"433.521795ms","remote":"127.0.0.1:60984","response type":"/etcdserverpb.KV/Range","request count":0,"request size":65,"response count":1,"response size":2015,"request content":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" "} {"level":"warn","ts":"2026-06-16T12:30:09.398498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"376.458108ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-16T12:30:09.398601Z","caller":"traceutil/trace.go:171","msg":"trace[1938786895] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:26153; }","duration":"376.636222ms","start":"2026-06-16T12:30:09.021942Z","end":"2026-06-16T12:30:09.398578Z","steps":["trace[1938786895] 'agreement among raft nodes before linearized reading' (duration: 376.441708ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T12:30:09.398656Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T12:30:09.021911Z","time spent":"376.732766ms","remote":"127.0.0.1:32856","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":18,"response size":32,"request content":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true "} {"level":"warn","ts":"2026-06-16T12:30:09.398818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.554021ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12217"} {"level":"info","ts":"2026-06-16T12:30:09.398849Z","caller":"traceutil/trace.go:171","msg":"trace[1640874130] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:26153; }","duration":"189.585251ms","start":"2026-06-16T12:30:09.209257Z","end":"2026-06-16T12:30:09.398842Z","steps":["trace[1640874130] 'agreement among raft nodes before linearized reading' (duration: 189.50226ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T12:30:09.398982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.245764ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"warn","ts":"2026-06-16T12:30:09.399002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"696.847431ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rook-ceph-pdbstatemap\" ","response":"range_response_count:1 size:357"} {"level":"info","ts":"2026-06-16T12:30:09.399025Z","caller":"traceutil/trace.go:171","msg":"trace[202435406] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-pdbstatemap; range_end:; response_count:1; response_revision:26153; }","duration":"696.928743ms","start":"2026-06-16T12:30:08.70209Z","end":"2026-06-16T12:30:09.399019Z","steps":["trace[202435406] 'agreement among raft nodes before linearized reading' (duration: 696.860051ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T12:30:09.399024Z","caller":"traceutil/trace.go:171","msg":"trace[1912016017] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26153; }","duration":"210.339595ms","start":"2026-06-16T12:30:09.188674Z","end":"2026-06-16T12:30:09.399014Z","steps":["trace[1912016017] 'agreement among raft nodes before linearized reading' (duration: 210.192633ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T12:30:09.399041Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T12:30:08.702054Z","time spent":"696.983074ms","remote":"127.0.0.1:60892","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":381,"request content":"key:\"/registry/configmaps/openstack/rook-ceph-pdbstatemap\" "} {"level":"warn","ts":"2026-06-16T12:30:09.399285Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T12:30:08.940961Z","time spent":"457.735528ms","remote":"127.0.0.1:32838","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":607,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-16T12:30:09.399349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.665979ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:9"} {"level":"info","ts":"2026-06-16T12:30:09.399383Z","caller":"traceutil/trace.go:171","msg":"trace[1864825839] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:26153; }","duration":"234.743571ms","start":"2026-06-16T12:30:09.16463Z","end":"2026-06-16T12:30:09.399373Z","steps":["trace[1864825839] 'agreement among raft nodes before linearized reading' (duration: 234.573688ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T12:30:09.741099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.690866ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-16T12:30:09.741342Z","caller":"traceutil/trace.go:171","msg":"trace[1052674795] transaction","detail":"{read_only:false; response_revision:26154; number_of_response:1; }","duration":"336.312215ms","start":"2026-06-16T12:30:09.404994Z","end":"2026-06-16T12:30:09.741306Z","steps":["trace[1052674795] 'process raft request' (duration: 160.321334ms)","trace[1052674795] 'compare' (duration: 175.337349ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T12:30:09.741371Z","caller":"traceutil/trace.go:171","msg":"trace[1944884162] transaction","detail":"{read_only:false; response_revision:26157; number_of_response:1; }","duration":"179.223024ms","start":"2026-06-16T12:30:09.562135Z","end":"2026-06-16T12:30:09.741358Z","steps":["trace[1944884162] 'process raft request' (duration: 179.183223ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T12:30:09.74141Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T12:30:09.404968Z","time spent":"336.416017ms","remote":"127.0.0.1:32838","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T12:30:09.741479Z","caller":"traceutil/trace.go:171","msg":"trace[1640390957] linearizableReadLoop","detail":"{readStateIndex:27028; appliedIndex:27027; }","duration":"333.96608ms","start":"2026-06-16T12:30:09.407503Z","end":"2026-06-16T12:30:09.741469Z","steps":["trace[1640390957] 'read index received' (duration: 157.826446ms)","trace[1640390957] 'applied index is now lower than readState.Index' (duration: 176.138704ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T12:30:09.741716Z","caller":"traceutil/trace.go:171","msg":"trace[439321338] transaction","detail":"{read_only:false; response_revision:26155; number_of_response:1; }","duration":"334.069523ms","start":"2026-06-16T12:30:09.407635Z","end":"2026-06-16T12:30:09.741704Z","steps":["trace[439321338] 'process raft request' (duration: 333.579793ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T12:30:09.741769Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T12:30:09.407621Z","time spent":"334.117273ms","remote":"127.0.0.1:32856","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":871,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T12:30:09.741899Z","caller":"traceutil/trace.go:171","msg":"trace[1460947634] transaction","detail":"{read_only:false; response_revision:26156; number_of_response:1; }","duration":"334.110273ms","start":"2026-06-16T12:30:09.40778Z","end":"2026-06-16T12:30:09.74189Z","steps":["trace[1460947634] 'process raft request' (duration: 333.500871ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T12:30:09.741944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T12:30:09.407692Z","time spent":"334.226776ms","remote":"127.0.0.1:32856","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":926,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-16T12:30:09.742004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.49945ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-16T12:30:09.742023Z","caller":"traceutil/trace.go:171","msg":"trace[195897407] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26157; }","duration":"334.545202ms","start":"2026-06-16T12:30:09.407471Z","end":"2026-06-16T12:30:09.742017Z","steps":["trace[195897407] 'agreement among raft nodes before linearized reading' (duration: 334.46025ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T12:30:09.742039Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T12:30:09.407464Z","time spent":"334.572092ms","remote":"127.0.0.1:32838","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-16T12:30:09.742227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.627273ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"warn","ts":"2026-06-16T12:30:09.742317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.285446ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12217"} {"level":"info","ts":"2026-06-16T12:30:09.742334Z","caller":"traceutil/trace.go:171","msg":"trace[1931468746] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26157; }","duration":"334.763875ms","start":"2026-06-16T12:30:09.407544Z","end":"2026-06-16T12:30:09.742308Z","steps":["trace[1931468746] 'agreement among raft nodes before linearized reading' (duration: 334.439099ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T12:30:09.742353Z","caller":"traceutil/trace.go:171","msg":"trace[1955295515] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:26157; }","duration":"324.338677ms","start":"2026-06-16T12:30:09.418002Z","end":"2026-06-16T12:30:09.742341Z","steps":["trace[1955295515] 'agreement among raft nodes before linearized reading' (duration: 324.236556ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T12:30:09.742384Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T12:30:09.417991Z","time spent":"324.387698ms","remote":"127.0.0.1:60970","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12241,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-06-16T12:30:09.742391Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T12:30:09.40754Z","time spent":"334.842146ms","remote":"127.0.0.1:32838","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":465,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-16T12:30:09.997673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.330758ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-16T12:30:09.997958Z","caller":"traceutil/trace.go:171","msg":"trace[113331714] linearizableReadLoop","detail":"{readStateIndex:27032; appliedIndex:27031; }","duration":"250.509091ms","start":"2026-06-16T12:30:09.747433Z","end":"2026-06-16T12:30:09.997942Z","steps":["trace[113331714] 'read index received' (duration: 104.723673ms)","trace[113331714] 'applied index is now lower than readState.Index' (duration: 145.784058ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T12:30:09.998015Z","caller":"traceutil/trace.go:171","msg":"trace[1545924524] transaction","detail":"{read_only:false; response_revision:26158; number_of_response:1; }","duration":"251.656133ms","start":"2026-06-16T12:30:09.746311Z","end":"2026-06-16T12:30:09.997967Z","steps":["trace[1545924524] 'process raft request' (duration: 105.829435ms)","trace[1545924524] 'compare' (duration: 145.024892ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T12:30:09.998239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.777945ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/container-infra.18b98f956043c0fc\" ","response":"range_response_count:1 size:695"} {"level":"info","ts":"2026-06-16T12:30:09.998337Z","caller":"traceutil/trace.go:171","msg":"trace[1259277473] range","detail":"{range_begin:/registry/events/openstack/container-infra.18b98f956043c0fc; range_end:; response_count:1; response_revision:26158; }","duration":"250.939229ms","start":"2026-06-16T12:30:09.747363Z","end":"2026-06-16T12:30:09.998302Z","steps":["trace[1259277473] 'agreement among raft nodes before linearized reading' (duration: 250.696305ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T12:30:10.001244Z","caller":"traceutil/trace.go:171","msg":"trace[1626165416] transaction","detail":"{read_only:false; response_revision:26159; number_of_response:1; }","duration":"251.348287ms","start":"2026-06-16T12:30:09.749849Z","end":"2026-06-16T12:30:10.001197Z","steps":["trace[1626165416] 'process raft request' (duration: 251.124673ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T12:30:10.01261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.282917ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-16T12:30:10.012723Z","caller":"traceutil/trace.go:171","msg":"trace[91192443] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:26160; }","duration":"198.44431ms","start":"2026-06-16T12:30:09.81425Z","end":"2026-06-16T12:30:10.012694Z","steps":["trace[91192443] 'agreement among raft nodes before linearized reading' (duration: 198.255717ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T12:30:10.012729Z","caller":"traceutil/trace.go:171","msg":"trace[469962388] transaction","detail":"{read_only:false; response_revision:26160; number_of_response:1; }","duration":"142.494004ms","start":"2026-06-16T12:30:09.870201Z","end":"2026-06-16T12:30:10.012696Z","steps":["trace[469962388] 'process raft request' (duration: 142.145908ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T12:30:10.480887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.496022ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-16T12:30:10.481019Z","caller":"traceutil/trace.go:171","msg":"trace[1468120132] transaction","detail":"{read_only:false; response_revision:26163; number_of_response:1; }","duration":"386.818527ms","start":"2026-06-16T12:30:10.09418Z","end":"2026-06-16T12:30:10.480998Z","steps":["trace[1468120132] 'process raft request' (duration: 138.11527ms)","trace[1468120132] 'compare' (duration: 247.874651ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T12:30:10.481083Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T12:30:10.094147Z","time spent":"386.904849ms","remote":"127.0.0.1:32838","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-16T12:30:10.827612Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976533110745127240,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-16T12:30:10.962473Z","caller":"traceutil/trace.go:171","msg":"trace[90285877] linearizableReadLoop","detail":"{readStateIndex:27040; appliedIndex:27037; }","duration":"635.3982ms","start":"2026-06-16T12:30:10.327045Z","end":"2026-06-16T12:30:10.962443Z","steps":["trace[90285877] 'read index received' (duration: 635.058934ms)","trace[90285877] 'applied index is now lower than readState.Index' (duration: 338.156µs)"],"step_count":2} {"level":"info","ts":"2026-06-16T12:30:10.962807Z","caller":"traceutil/trace.go:171","msg":"trace[2109495995] transaction","detail":"{read_only:false; response_revision:26164; number_of_response:1; }","duration":"868.545821ms","start":"2026-06-16T12:30:10.094245Z","end":"2026-06-16T12:30:10.962791Z","steps":["trace[2109495995] 'process raft request' (duration: 867.943929ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T12:30:10.962952Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T12:30:10.094211Z","time spent":"868.639213ms","remote":"127.0.0.1:32838","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":554,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T12:30:10.963166Z","caller":"traceutil/trace.go:171","msg":"trace[1994069494] transaction","detail":"{read_only:false; response_revision:26165; number_of_response:1; }","duration":"866.566783ms","start":"2026-06-16T12:30:10.096589Z","end":"2026-06-16T12:30:10.963156Z","steps":["trace[1994069494] 'process raft request' (duration: 865.765557ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T12:30:10.963227Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T12:30:10.096566Z","time spent":"866.630944ms","remote":"127.0.0.1:32838","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":497,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T12:30:10.96337Z","caller":"traceutil/trace.go:171","msg":"trace[709461124] transaction","detail":"{read_only:false; response_revision:26166; number_of_response:1; }","duration":"865.252728ms","start":"2026-06-16T12:30:10.098107Z","end":"2026-06-16T12:30:10.96336Z","steps":["trace[709461124] 'process raft request' (duration: 864.289469ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T12:30:10.963432Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T12:30:10.098093Z","time spent":"865.307268ms","remote":"127.0.0.1:32838","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-16T12:30:10.963603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"636.568332ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-16T12:30:10.963638Z","caller":"traceutil/trace.go:171","msg":"trace[32604745] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26166; }","duration":"636.647154ms","start":"2026-06-16T12:30:10.326982Z","end":"2026-06-16T12:30:10.963629Z","steps":["trace[32604745] 'agreement among raft nodes before linearized reading' (duration: 636.586453ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T12:30:10.963667Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T12:30:10.326956Z","time spent":"636.705635ms","remote":"127.0.0.1:60792","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":30,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-16T12:30:10.96402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"493.513269ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.238\" ","response":"range_response_count:1 size:140"} {"level":"info","ts":"2026-06-16T12:30:10.964068Z","caller":"traceutil/trace.go:171","msg":"trace[513122625] range","detail":"{range_begin:/registry/masterleases/199.204.45.238; range_end:; response_count:1; response_revision:26166; }","duration":"493.59303ms","start":"2026-06-16T12:30:10.470452Z","end":"2026-06-16T12:30:10.964045Z","steps":["trace[513122625] 'agreement among raft nodes before linearized reading' (duration: 493.396306ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T12:30:10.964097Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T12:30:10.470427Z","time spent":"493.664072ms","remote":"127.0.0.1:60828","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":164,"request content":"key:\"/registry/masterleases/199.204.45.238\" "} {"level":"warn","ts":"2026-06-16T12:30:10.964713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.914496ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-06-16T12:30:10.964745Z","caller":"traceutil/trace.go:171","msg":"trace[697887962] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26166; }","duration":"336.978608ms","start":"2026-06-16T12:30:10.627757Z","end":"2026-06-16T12:30:10.964735Z","steps":["trace[697887962] 'agreement among raft nodes before linearized reading' (duration: 336.882886ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T12:30:10.964772Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T12:30:10.627733Z","time spent":"337.032749ms","remote":"127.0.0.1:32838","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":506,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-16T12:30:10.965172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"436.38956ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-octavia-server-0\" ","response":"range_response_count:1 size:1864"} {"level":"info","ts":"2026-06-16T12:30:10.965275Z","caller":"traceutil/trace.go:171","msg":"trace[33772960] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-octavia-server-0; range_end:; response_count:1; response_revision:26166; }","duration":"436.560493ms","start":"2026-06-16T12:30:10.528688Z","end":"2026-06-16T12:30:10.965249Z","steps":["trace[33772960] 'agreement among raft nodes before linearized reading' (duration: 436.263918ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T12:30:10.965328Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T12:30:10.528639Z","time spent":"436.679556ms","remote":"127.0.0.1:60956","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":1,"response size":1888,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-octavia-server-0\" "} {"level":"info","ts":"2026-06-16T12:30:13.060836Z","caller":"traceutil/trace.go:171","msg":"trace[1324562512] transaction","detail":"{read_only:false; response_revision:26182; number_of_response:1; }","duration":"174.893521ms","start":"2026-06-16T12:30:12.885908Z","end":"2026-06-16T12:30:13.060802Z","steps":["trace[1324562512] 'process raft request' (duration: 174.721138ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T12:30:13.18899Z","caller":"traceutil/trace.go:171","msg":"trace[52667624] linearizableReadLoop","detail":"{readStateIndex:27060; appliedIndex:27056; }","duration":"209.612012ms","start":"2026-06-16T12:30:12.979355Z","end":"2026-06-16T12:30:13.188967Z","steps":["trace[52667624] 'read index received' (duration: 81.261457ms)","trace[52667624] 'applied index is now lower than readState.Index' (duration: 128.349085ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T12:30:13.189084Z","caller":"traceutil/trace.go:171","msg":"trace[34390855] transaction","detail":"{read_only:false; response_revision:26183; number_of_response:1; }","duration":"218.512492ms","start":"2026-06-16T12:30:12.970551Z","end":"2026-06-16T12:30:13.189063Z","steps":["trace[34390855] 'process raft request' (duration: 131.634207ms)","trace[34390855] 'compare' (duration: 86.318283ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T12:30:13.189075Z","caller":"traceutil/trace.go:171","msg":"trace[361403148] transaction","detail":"{read_only:false; response_revision:26184; number_of_response:1; }","duration":"217.806329ms","start":"2026-06-16T12:30:12.971214Z","end":"2026-06-16T12:30:13.189021Z","steps":["trace[361403148] 'process raft request' (duration: 217.601335ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T12:30:13.189147Z","caller":"traceutil/trace.go:171","msg":"trace[1205105071] transaction","detail":"{read_only:false; response_revision:26186; number_of_response:1; }","duration":"170.332904ms","start":"2026-06-16T12:30:13.018807Z","end":"2026-06-16T12:30:13.189139Z","steps":["trace[1205105071] 'process raft request' (duration: 170.12569ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T12:30:13.18912Z","caller":"traceutil/trace.go:171","msg":"trace[542211699] transaction","detail":"{read_only:false; response_revision:26185; number_of_response:1; }","duration":"217.795828ms","start":"2026-06-16T12:30:12.971313Z","end":"2026-06-16T12:30:13.189109Z","steps":["trace[542211699] 'process raft request' (duration: 217.578704ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T12:30:13.189392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.00855ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclusters/\" range_end:\"/registry/ceph.rook.io/cephclusters0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-16T12:30:13.18943Z","caller":"traceutil/trace.go:171","msg":"trace[1352878056] range","detail":"{range_begin:/registry/ceph.rook.io/cephclusters/; range_end:/registry/ceph.rook.io/cephclusters0; response_count:0; response_revision:26186; }","duration":"210.073531ms","start":"2026-06-16T12:30:12.979346Z","end":"2026-06-16T12:30:13.18942Z","steps":["trace[1352878056] 'agreement among raft nodes before linearized reading' (duration: 209.935499ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T12:30:13.189565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.811743ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-16T12:30:13.189607Z","caller":"traceutil/trace.go:171","msg":"trace[830700898] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:26186; }","duration":"201.915165ms","start":"2026-06-16T12:30:12.987677Z","end":"2026-06-16T12:30:13.189593Z","steps":["trace[830700898] 'agreement among raft nodes before linearized reading' (duration: 201.805693ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T12:30:13.189822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.126976ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-06-16T12:30:13.189865Z","caller":"traceutil/trace.go:171","msg":"trace[1043697955] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26186; }","duration":"173.211818ms","start":"2026-06-16T12:30:13.016644Z","end":"2026-06-16T12:30:13.189856Z","steps":["trace[1043697955] 'agreement among raft nodes before linearized reading' (duration: 173.082196ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T12:30:13.190156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.075011ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-06-16T12:30:13.190186Z","caller":"traceutil/trace.go:171","msg":"trace[620858686] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26186; }","duration":"168.134643ms","start":"2026-06-16T12:30:13.022043Z","end":"2026-06-16T12:30:13.190178Z","steps":["trace[620858686] 'agreement among raft nodes before linearized reading' (duration: 168.004969ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T12:30:13.481623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.718366ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-16T12:30:13.481723Z","caller":"traceutil/trace.go:171","msg":"trace[1334194627] transaction","detail":"{read_only:false; response_revision:26187; number_of_response:1; }","duration":"287.234921ms","start":"2026-06-16T12:30:13.194469Z","end":"2026-06-16T12:30:13.481704Z","steps":["trace[1334194627] 'process raft request' (duration: 131.343251ms)","trace[1334194627] 'compare' (duration: 155.449081ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T12:30:13.507585Z","caller":"traceutil/trace.go:171","msg":"trace[760425494] linearizableReadLoop","detail":"{readStateIndex:27063; appliedIndex:27062; }","duration":"174.420411ms","start":"2026-06-16T12:30:13.333135Z","end":"2026-06-16T12:30:13.507556Z","steps":["trace[760425494] 'read index received' (duration: 174.296549ms)","trace[760425494] 'applied index is now lower than readState.Index' (duration: 122.472µs)"],"step_count":2} {"level":"warn","ts":"2026-06-16T12:30:13.507756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.596055ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-16T12:30:13.507794Z","caller":"traceutil/trace.go:171","msg":"trace[1629659854] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26188; }","duration":"174.702977ms","start":"2026-06-16T12:30:13.333078Z","end":"2026-06-16T12:30:13.507781Z","steps":["trace[1629659854] 'agreement among raft nodes before linearized reading' (duration: 174.584504ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T12:30:13.508178Z","caller":"traceutil/trace.go:171","msg":"trace[1686163353] transaction","detail":"{read_only:false; response_revision:26188; number_of_response:1; }","duration":"312.844359ms","start":"2026-06-16T12:30:13.195318Z","end":"2026-06-16T12:30:13.508162Z","steps":["trace[1686163353] 'process raft request' (duration: 312.097424ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T12:30:13.508287Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T12:30:13.195309Z","time spent":"312.90457ms","remote":"127.0.0.1:32838","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T12:30:13.869614Z","caller":"traceutil/trace.go:171","msg":"trace[923586838] transaction","detail":"{read_only:false; response_revision:26190; number_of_response:1; }","duration":"110.383693ms","start":"2026-06-16T12:30:13.759201Z","end":"2026-06-16T12:30:13.869585Z","steps":["trace[923586838] 'process raft request' (duration: 110.203939ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T12:30:13.870911Z","caller":"traceutil/trace.go:171","msg":"trace[50110329] transaction","detail":"{read_only:false; response_revision:26191; number_of_response:1; }","duration":"106.207883ms","start":"2026-06-16T12:30:13.764686Z","end":"2026-06-16T12:30:13.870894Z","steps":["trace[50110329] 'process raft request' (duration: 106.125761ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T12:30:14.351605Z","caller":"traceutil/trace.go:171","msg":"trace[1431669913] transaction","detail":"{read_only:false; response_revision:26193; number_of_response:1; }","duration":"281.177486ms","start":"2026-06-16T12:30:14.070399Z","end":"2026-06-16T12:30:14.351577Z","steps":["trace[1431669913] 'process raft request' (duration: 280.971222ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T12:30:14.367619Z","caller":"traceutil/trace.go:171","msg":"trace[1707113288] transaction","detail":"{read_only:false; response_revision:26194; number_of_response:1; }","duration":"296.606698ms","start":"2026-06-16T12:30:14.070987Z","end":"2026-06-16T12:30:14.367593Z","steps":["trace[1707113288] 'process raft request' (duration: 296.433365ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T12:30:25.482767Z","caller":"traceutil/trace.go:171","msg":"trace[1607138825] transaction","detail":"{read_only:false; response_revision:26282; number_of_response:1; }","duration":"244.574118ms","start":"2026-06-16T12:30:25.238144Z","end":"2026-06-16T12:30:25.482718Z","steps":["trace[1607138825] 'process raft request' (duration: 219.079232ms)","trace[1607138825] 'compare' (duration: 25.217431ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T12:30:25.48277Z","caller":"traceutil/trace.go:171","msg":"trace[694506058] transaction","detail":"{read_only:false; response_revision:26283; number_of_response:1; }","duration":"244.549657ms","start":"2026-06-16T12:30:25.238187Z","end":"2026-06-16T12:30:25.482736Z","steps":["trace[694506058] 'process raft request' (duration: 244.430315ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T12:30:25.482921Z","caller":"traceutil/trace.go:171","msg":"trace[2077202942] linearizableReadLoop","detail":"{readStateIndex:27161; appliedIndex:27157; }","duration":"191.393924ms","start":"2026-06-16T12:30:25.291496Z","end":"2026-06-16T12:30:25.48289Z","steps":["trace[2077202942] 'read index received' (duration: 4.329962ms)","trace[2077202942] 'applied index is now lower than readState.Index' (duration: 187.061692ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T12:30:25.483042Z","caller":"traceutil/trace.go:171","msg":"trace[871243726] transaction","detail":"{read_only:false; response_revision:26284; number_of_response:1; }","duration":"244.328733ms","start":"2026-06-16T12:30:25.238705Z","end":"2026-06-16T12:30:25.483033Z","steps":["trace[871243726] 'process raft request' (duration: 243.966956ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T12:30:25.483211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.755365ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-16T12:30:25.483307Z","caller":"traceutil/trace.go:171","msg":"trace[236403830] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26284; }","duration":"156.897208ms","start":"2026-06-16T12:30:25.326389Z","end":"2026-06-16T12:30:25.483286Z","steps":["trace[236403830] 'agreement among raft nodes before linearized reading' (duration: 156.721065ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T12:30:25.483318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.789561ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12217"} {"level":"info","ts":"2026-06-16T12:30:25.483375Z","caller":"traceutil/trace.go:171","msg":"trace[1751521550] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:26284; }","duration":"191.906556ms","start":"2026-06-16T12:30:25.291453Z","end":"2026-06-16T12:30:25.48336Z","steps":["trace[1751521550] 'agreement among raft nodes before linearized reading' (duration: 191.65892ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T12:30:27.679192Z","caller":"traceutil/trace.go:171","msg":"trace[1551781105] transaction","detail":"{read_only:false; response_revision:26296; number_of_response:1; }","duration":"190.253143ms","start":"2026-06-16T12:30:27.4889Z","end":"2026-06-16T12:30:27.679154Z","steps":["trace[1551781105] 'process raft request' (duration: 190.024009ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T12:30:27.810938Z","caller":"traceutil/trace.go:171","msg":"trace[1857033941] linearizableReadLoop","detail":"{readStateIndex:27176; appliedIndex:27173; }","duration":"251.238996ms","start":"2026-06-16T12:30:27.559671Z","end":"2026-06-16T12:30:27.81091Z","steps":["trace[1857033941] 'read index received' (duration: 119.423635ms)","trace[1857033941] 'applied index is now lower than readState.Index' (duration: 131.814091ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T12:30:27.811108Z","caller":"traceutil/trace.go:171","msg":"trace[1814473038] transaction","detail":"{read_only:false; response_revision:26299; number_of_response:1; }","duration":"169.138352ms","start":"2026-06-16T12:30:27.64195Z","end":"2026-06-16T12:30:27.811088Z","steps":["trace[1814473038] 'process raft request' (duration: 168.911288ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T12:30:27.811235Z","caller":"traceutil/trace.go:171","msg":"trace[287346738] transaction","detail":"{read_only:false; response_revision:26297; number_of_response:1; }","duration":"320.918481ms","start":"2026-06-16T12:30:27.4903Z","end":"2026-06-16T12:30:27.811219Z","steps":["trace[287346738] 'process raft request' (duration: 320.32723ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T12:30:27.811359Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T12:30:27.490259Z","time spent":"321.012333ms","remote":"127.0.0.1:32838","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T12:30:27.81136Z","caller":"traceutil/trace.go:171","msg":"trace[1028226933] transaction","detail":"{read_only:false; response_revision:26298; number_of_response:1; }","duration":"320.768279ms","start":"2026-06-16T12:30:27.490551Z","end":"2026-06-16T12:30:27.811319Z","steps":["trace[1028226933] 'process raft request' (duration: 320.26843ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T12:30:27.81157Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T12:30:27.490513Z","time spent":"320.927381ms","remote":"127.0.0.1:32838","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-16T12:30:27.811625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.932348ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-glance-server-0\" ","response":"range_response_count:1 size:1858"} {"level":"info","ts":"2026-06-16T12:30:27.811677Z","caller":"traceutil/trace.go:171","msg":"trace[1788159088] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-glance-server-0; range_end:; response_count:1; response_revision:26299; }","duration":"252.04146ms","start":"2026-06-16T12:30:27.559617Z","end":"2026-06-16T12:30:27.811659Z","steps":["trace[1788159088] 'agreement among raft nodes before linearized reading' (duration: 251.845757ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T12:30:27.811695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.862146ms","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:8"} {"level":"info","ts":"2026-06-16T12:30:27.811773Z","caller":"traceutil/trace.go:171","msg":"trace[176510697] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectstores/; range_end:/registry/ceph.rook.io/cephobjectstores0; response_count:0; response_revision:26299; }","duration":"167.996349ms","start":"2026-06-16T12:30:27.643754Z","end":"2026-06-16T12:30:27.81175Z","steps":["trace[176510697] 'agreement among raft nodes before linearized reading' (duration: 167.820225ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T12:30:27.811746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.391561ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-06-16T12:30:27.811842Z","caller":"traceutil/trace.go:171","msg":"trace[952949922] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26299; }","duration":"237.586455ms","start":"2026-06-16T12:30:27.574232Z","end":"2026-06-16T12:30:27.811819Z","steps":["trace[952949922] 'agreement among raft nodes before linearized reading' (duration: 237.137686ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T12:30:27.811851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.201029ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-06-16T12:30:27.811901Z","caller":"traceutil/trace.go:171","msg":"trace[197090607] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26299; }","duration":"173.3067ms","start":"2026-06-16T12:30:27.63858Z","end":"2026-06-16T12:30:27.811887Z","steps":["trace[197090607] 'agreement among raft nodes before linearized reading' (duration: 173.140686ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T12:30:28.415653Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.431806ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-16T12:30:28.416209Z","caller":"traceutil/trace.go:171","msg":"trace[1440403360] transaction","detail":"{read_only:false; response_revision:26301; number_of_response:1; }","duration":"599.308123ms","start":"2026-06-16T12:30:27.816867Z","end":"2026-06-16T12:30:28.416175Z","steps":["trace[1440403360] 'process raft request' (duration: 303.017981ms)","trace[1440403360] 'compare' (duration: 294.559779ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T12:30:28.416313Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T12:30:27.816851Z","time spent":"599.420196ms","remote":"127.0.0.1:32838","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T12:30:28.94087Z","caller":"traceutil/trace.go:171","msg":"trace[195782171] transaction","detail":"{read_only:false; response_revision:26302; number_of_response:1; }","duration":"1.017938376s","start":"2026-06-16T12:30:27.922885Z","end":"2026-06-16T12:30:28.940823Z","steps":["trace[195782171] 'process raft request' (duration: 1.000290369s)","trace[195782171] 'compare' (duration: 17.345731ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T12:30:28.940898Z","caller":"traceutil/trace.go:171","msg":"trace[1473969373] linearizableReadLoop","detail":"{readStateIndex:27180; appliedIndex:27178; }","duration":"1.00347153s","start":"2026-06-16T12:30:27.937391Z","end":"2026-06-16T12:30:28.940863Z","steps":["trace[1473969373] 'read index received' (duration: 182.515136ms)","trace[1473969373] 'applied index is now lower than readState.Index' (duration: 820.955174ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T12:30:28.940856Z","caller":"traceutil/trace.go:171","msg":"trace[1129660329] transaction","detail":"{read_only:false; response_revision:26303; number_of_response:1; }","duration":"866.477662ms","start":"2026-06-16T12:30:28.074343Z","end":"2026-06-16T12:30:28.94082Z","steps":["trace[1129660329] 'process raft request' (duration: 866.37592ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T12:30:28.941024Z","caller":"traceutil/trace.go:171","msg":"trace[1917650844] transaction","detail":"{read_only:false; response_revision:26304; number_of_response:1; }","duration":"825.181585ms","start":"2026-06-16T12:30:28.115802Z","end":"2026-06-16T12:30:28.940984Z","steps":["trace[1917650844] 'process raft request' (duration: 824.980211ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T12:30:28.941101Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T12:30:27.922865Z","time spent":"1.018104568s","remote":"127.0.0.1:32838","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-16T12:30:28.941146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.003736645s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"warn","ts":"2026-06-16T12:30:28.941244Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T12:30:28.115767Z","time spent":"825.352337ms","remote":"127.0.0.1:32838","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T12:30:28.941293Z","caller":"traceutil/trace.go:171","msg":"trace[1053709992] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26304; }","duration":"1.00398291s","start":"2026-06-16T12:30:27.937293Z","end":"2026-06-16T12:30:28.941276Z","steps":["trace[1053709992] 'agreement among raft nodes before linearized reading' (duration: 1.003652884s)"],"step_count":1} {"level":"warn","ts":"2026-06-16T12:30:28.941771Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T12:30:27.937186Z","time spent":"1.004161473s","remote":"127.0.0.1:32838","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":533,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-16T12:30:28.941995Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T12:30:28.074312Z","time spent":"867.523121ms","remote":"127.0.0.1:32838","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-16T12:30:28.942147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"709.735867ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-16T12:30:28.942208Z","caller":"traceutil/trace.go:171","msg":"trace[885820610] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:26305; }","duration":"709.852549ms","start":"2026-06-16T12:30:28.232336Z","end":"2026-06-16T12:30:28.942189Z","steps":["trace[885820610] 'agreement among raft nodes before linearized reading' (duration: 709.721876ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T12:30:28.942248Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T12:30:28.232305Z","time spent":"709.93329ms","remote":"127.0.0.1:52412","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":32,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "} {"level":"warn","ts":"2026-06-16T12:30:28.942272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"510.145435ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-06-16T12:30:28.942243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"396.143004ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-16T12:30:28.942416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.771148ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-heat-server-0\" ","response":"range_response_count:1 size:1852"} {"level":"info","ts":"2026-06-16T12:30:28.942329Z","caller":"traceutil/trace.go:171","msg":"trace[571889297] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26305; }","duration":"510.229206ms","start":"2026-06-16T12:30:28.432086Z","end":"2026-06-16T12:30:28.942315Z","steps":["trace[571889297] 'agreement among raft nodes before linearized reading' (duration: 510.023812ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T12:30:28.942459Z","caller":"traceutil/trace.go:171","msg":"trace[692851185] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-heat-server-0; range_end:; response_count:1; response_revision:26305; }","duration":"405.86482ms","start":"2026-06-16T12:30:28.536584Z","end":"2026-06-16T12:30:28.942449Z","steps":["trace[692851185] 'agreement among raft nodes before linearized reading' (duration: 405.766058ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T12:30:28.942469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"510.824209ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"warn","ts":"2026-06-16T12:30:28.942512Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T12:30:28.536558Z","time spent":"405.946001ms","remote":"127.0.0.1:60956","response type":"/etcdserverpb.KV/Range","request count":0,"request size":79,"response count":1,"response size":1876,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-heat-server-0\" "} {"level":"info","ts":"2026-06-16T12:30:28.942524Z","caller":"traceutil/trace.go:171","msg":"trace[1677607719] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26305; }","duration":"510.941601ms","start":"2026-06-16T12:30:28.431562Z","end":"2026-06-16T12:30:28.942504Z","steps":["trace[1677607719] 'agreement among raft nodes before linearized reading' (duration: 510.733707ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T12:30:28.942572Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T12:30:28.431538Z","time spent":"511.027552ms","remote":"127.0.0.1:32838","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":465,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-16T12:30:28.942507Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T12:30:28.432074Z","time spent":"510.41527ms","remote":"127.0.0.1:32838","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-16T12:30:28.942393Z","caller":"traceutil/trace.go:171","msg":"trace[1913731637] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0; response_count:0; response_revision:26305; }","duration":"396.413739ms","start":"2026-06-16T12:30:28.545953Z","end":"2026-06-16T12:30:28.942367Z","steps":["trace[1913731637] 'agreement among raft nodes before linearized reading' (duration: 396.137204ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T12:30:28.942696Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T12:30:28.545912Z","time spent":"396.756086ms","remote":"127.0.0.1:58820","response type":"/etcdserverpb.KV/Range","request count":0,"request size":152,"response count":0,"response size":30,"request content":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0\" "} {"level":"info","ts":"2026-06-16T12:30:28.942722Z","caller":"traceutil/trace.go:171","msg":"trace[933291606] transaction","detail":"{read_only:false; response_revision:26305; number_of_response:1; }","duration":"388.735252ms","start":"2026-06-16T12:30:28.553964Z","end":"2026-06-16T12:30:28.942699Z","steps":["trace[933291606] 'process raft request' (duration: 387.935448ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T12:30:28.942871Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T12:30:28.553945Z","time spent":"388.831695ms","remote":"127.0.0.1:32838","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-16T12:30:29.510596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.306455ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-16T12:30:29.51115Z","caller":"traceutil/trace.go:171","msg":"trace[677284960] transaction","detail":"{read_only:false; response_revision:26308; number_of_response:1; }","duration":"562.652676ms","start":"2026-06-16T12:30:28.948478Z","end":"2026-06-16T12:30:29.511131Z","steps":["trace[677284960] 'process raft request' (duration: 562.616475ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T12:30:29.511094Z","caller":"traceutil/trace.go:171","msg":"trace[1601764446] transaction","detail":"{read_only:false; response_revision:26306; number_of_response:1; }","duration":"563.722105ms","start":"2026-06-16T12:30:28.947316Z","end":"2026-06-16T12:30:29.511038Z","steps":["trace[1601764446] 'process raft request' (duration: 258.850189ms)","trace[1601764446] 'compare' (duration: 304.099462ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T12:30:29.511287Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T12:30:28.948448Z","time spent":"562.781207ms","remote":"127.0.0.1:32838","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-16T12:30:29.51146Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T12:30:28.947283Z","time spent":"563.99171ms","remote":"127.0.0.1:32838","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T12:30:29.511512Z","caller":"traceutil/trace.go:171","msg":"trace[2122862481] transaction","detail":"{read_only:false; response_revision:26307; number_of_response:1; }","duration":"563.180535ms","start":"2026-06-16T12:30:28.948282Z","end":"2026-06-16T12:30:29.511463Z","steps":["trace[2122862481] 'process raft request' (duration: 562.756937ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T12:30:29.511599Z","caller":"traceutil/trace.go:171","msg":"trace[1034535520] linearizableReadLoop","detail":"{readStateIndex:27184; appliedIndex:27183; }","duration":"562.959581ms","start":"2026-06-16T12:30:28.948165Z","end":"2026-06-16T12:30:29.511125Z","steps":["trace[1034535520] 'read index received' (duration: 258.015213ms)","trace[1034535520] 'applied index is now lower than readState.Index' (duration: 304.939857ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T12:30:29.511652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"563.464282ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/magnum-system/\" range_end:\"/registry/services/specs/magnum-system0\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-16T12:30:29.511733Z","caller":"traceutil/trace.go:171","msg":"trace[1837697410] range","detail":"{range_begin:/registry/services/specs/magnum-system/; range_end:/registry/services/specs/magnum-system0; response_count:0; response_revision:26308; }","duration":"563.602033ms","start":"2026-06-16T12:30:28.948114Z","end":"2026-06-16T12:30:29.511716Z","steps":["trace[1837697410] 'agreement among raft nodes before linearized reading' (duration: 563.43399ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T12:30:29.511778Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T12:30:28.948093Z","time spent":"563.676605ms","remote":"127.0.0.1:60984","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":30,"request content":"key:\"/registry/services/specs/magnum-system/\" range_end:\"/registry/services/specs/magnum-system0\" "} {"level":"warn","ts":"2026-06-16T12:30:29.511775Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T12:30:28.94826Z","time spent":"563.36441ms","remote":"127.0.0.1:32838","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-16T12:30:29.875583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.212707ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-16T12:30:29.875705Z","caller":"traceutil/trace.go:171","msg":"trace[848041347] linearizableReadLoop","detail":"{readStateIndex:27187; appliedIndex:27186; }","duration":"364.003342ms","start":"2026-06-16T12:30:29.511683Z","end":"2026-06-16T12:30:29.875686Z","steps":["trace[848041347] 'read index received' (duration: 105.425597ms)","trace[848041347] 'applied index is now lower than readState.Index' (duration: 258.576215ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T12:30:29.875793Z","caller":"traceutil/trace.go:171","msg":"trace[542342648] transaction","detail":"{read_only:false; response_revision:26309; number_of_response:1; }","duration":"566.294245ms","start":"2026-06-16T12:30:29.309463Z","end":"2026-06-16T12:30:29.875757Z","steps":["trace[542342648] 'process raft request' (duration: 307.762881ms)","trace[542342648] 'compare' (duration: 257.990153ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T12:30:29.876021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"550.121167ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-16T12:30:29.876019Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T12:30:29.309429Z","time spent":"566.452268ms","remote":"127.0.0.1:32838","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":498,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T12:30:29.876078Z","caller":"traceutil/trace.go:171","msg":"trace[1001547219] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26309; }","duration":"550.234969ms","start":"2026-06-16T12:30:29.325831Z","end":"2026-06-16T12:30:29.876066Z","steps":["trace[1001547219] 'agreement among raft nodes before linearized reading' (duration: 549.936233ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T12:30:29.876115Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T12:30:29.325802Z","time spent":"550.306169ms","remote":"127.0.0.1:60792","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":30,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-16T12:30:30.336534Z","caller":"traceutil/trace.go:171","msg":"trace[660689941] transaction","detail":"{read_only:false; response_revision:26310; number_of_response:1; }","duration":"650.313986ms","start":"2026-06-16T12:30:29.686187Z","end":"2026-06-16T12:30:30.336501Z","steps":["trace[660689941] 'process raft request' (duration: 650.113572ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T12:30:30.336724Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T12:30:29.686157Z","time spent":"650.462058ms","remote":"127.0.0.1:32838","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T12:30:30.368862Z","caller":"traceutil/trace.go:171","msg":"trace[1075924295] transaction","detail":"{read_only:false; response_revision:26311; number_of_response:1; }","duration":"550.746239ms","start":"2026-06-16T12:30:29.818096Z","end":"2026-06-16T12:30:30.368842Z","steps":["trace[1075924295] 'process raft request' (duration: 550.555506ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T12:30:30.368989Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T12:30:29.818068Z","time spent":"550.853741ms","remote":"127.0.0.1:32838","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T12:30:30.36921Z","caller":"traceutil/trace.go:171","msg":"trace[1278256665] transaction","detail":"{read_only:false; response_revision:26312; number_of_response:1; }","duration":"551.057484ms","start":"2026-06-16T12:30:29.81814Z","end":"2026-06-16T12:30:30.369197Z","steps":["trace[1278256665] 'process raft request' (duration: 550.648206ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T12:30:30.369291Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T12:30:29.818114Z","time spent":"551.140476ms","remote":"127.0.0.1:32838","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":607,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T12:30:30.369516Z","caller":"traceutil/trace.go:171","msg":"trace[1279218391] linearizableReadLoop","detail":"{readStateIndex:27191; appliedIndex:27187; }","duration":"493.743753ms","start":"2026-06-16T12:30:29.875732Z","end":"2026-06-16T12:30:30.369475Z","steps":["trace[1279218391] 'read index received' (duration: 460.572062ms)","trace[1279218391] 'applied index is now lower than readState.Index' (duration: 33.168921ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T12:30:30.369649Z","caller":"traceutil/trace.go:171","msg":"trace[1029798831] transaction","detail":"{read_only:false; response_revision:26313; number_of_response:1; }","duration":"551.326239ms","start":"2026-06-16T12:30:29.81829Z","end":"2026-06-16T12:30:30.369616Z","steps":["trace[1029798831] 'process raft request' (duration: 550.83584ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T12:30:30.369733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"851.787841ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/magnum-system/\" range_end:\"/registry/endpointslices/magnum-system0\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-16T12:30:30.369801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"491.781046ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-16T12:30:30.369823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.175347ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/applicationcredentials/\" range_end:\"/registry/openstack.k-orc.cloud/applicationcredentials0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-16T12:30:30.369841Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T12:30:29.818256Z","time spent":"551.460321ms","remote":"127.0.0.1:32838","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T12:30:30.369849Z","caller":"traceutil/trace.go:171","msg":"trace[958835984] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26313; }","duration":"491.917859ms","start":"2026-06-16T12:30:29.877917Z","end":"2026-06-16T12:30:30.369835Z","steps":["trace[958835984] 'agreement among raft nodes before linearized reading' (duration: 491.741494ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T12:30:30.369847Z","caller":"traceutil/trace.go:171","msg":"trace[1395061986] range","detail":"{range_begin:/registry/endpointslices/magnum-system/; range_end:/registry/endpointslices/magnum-system0; response_count:0; response_revision:26313; }","duration":"851.923734ms","start":"2026-06-16T12:30:29.517901Z","end":"2026-06-16T12:30:30.369824Z","steps":["trace[1395061986] 'agreement among raft nodes before linearized reading' (duration: 851.72563ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T12:30:30.369892Z","caller":"traceutil/trace.go:171","msg":"trace[1265728614] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/applicationcredentials/; range_end:/registry/openstack.k-orc.cloud/applicationcredentials0; response_count:0; response_revision:26313; }","duration":"332.315869ms","start":"2026-06-16T12:30:30.037557Z","end":"2026-06-16T12:30:30.369873Z","steps":["trace[1265728614] 'agreement among raft nodes before linearized reading' (duration: 332.194976ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T12:30:30.369897Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T12:30:29.877894Z","time spent":"491.994621ms","remote":"127.0.0.1:60796","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":30,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-16T12:30:30.369913Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T12:30:29.517835Z","time spent":"852.067577ms","remote":"127.0.0.1:32842","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":30,"request content":"key:\"/registry/endpointslices/magnum-system/\" range_end:\"/registry/endpointslices/magnum-system0\" "} {"level":"warn","ts":"2026-06-16T12:30:30.369935Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T12:30:30.037523Z","time spent":"332.399761ms","remote":"127.0.0.1:41908","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":30,"request content":"key:\"/registry/openstack.k-orc.cloud/applicationcredentials/\" range_end:\"/registry/openstack.k-orc.cloud/applicationcredentials0\" count_only:true "} {"level":"warn","ts":"2026-06-16T12:30:30.369985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"467.417652ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-06-16T12:30:30.370104Z","caller":"traceutil/trace.go:171","msg":"trace[413414188] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26313; }","duration":"467.574035ms","start":"2026-06-16T12:30:29.9025Z","end":"2026-06-16T12:30:30.370074Z","steps":["trace[413414188] 'agreement among raft nodes before linearized reading' (duration: 467.29106ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T12:30:30.370165Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T12:30:29.902488Z","time spent":"467.665706ms","remote":"127.0.0.1:32838","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":519,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-16T12:30:30.655978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.680677ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.238\" ","response":"range_response_count:1 size:140"} {"level":"info","ts":"2026-06-16T12:30:30.656076Z","caller":"traceutil/trace.go:171","msg":"trace[1803697021] range","detail":"{range_begin:/registry/masterleases/199.204.45.238; range_end:; response_count:1; response_revision:26314; }","duration":"184.820199ms","start":"2026-06-16T12:30:30.471239Z","end":"2026-06-16T12:30:30.656059Z","steps":["trace[1803697021] 'range keys from in-memory index tree' (duration: 184.457293ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T12:30:30.656462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.581326ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-06-16T12:30:30.657563Z","caller":"traceutil/trace.go:171","msg":"trace[363939345] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26314; }","duration":"236.746438ms","start":"2026-06-16T12:30:30.420791Z","end":"2026-06-16T12:30:30.657537Z","steps":["trace[363939345] 'range keys from in-memory index tree' (duration: 235.304101ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T12:30:30.852441Z","caller":"traceutil/trace.go:171","msg":"trace[1929762399] transaction","detail":"{read_only:false; response_revision:26315; number_of_response:1; }","duration":"191.055598ms","start":"2026-06-16T12:30:30.661357Z","end":"2026-06-16T12:30:30.852412Z","steps":["trace[1929762399] 'process raft request' (duration: 190.877855ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T12:30:30.87804Z","caller":"traceutil/trace.go:171","msg":"trace[1012094893] linearizableReadLoop","detail":"{readStateIndex:27195; appliedIndex:27193; }","duration":"189.194213ms","start":"2026-06-16T12:30:30.688807Z","end":"2026-06-16T12:30:30.878002Z","steps":["trace[1012094893] 'read index received' (duration: 163.463844ms)","trace[1012094893] 'applied index is now lower than readState.Index' (duration: 25.728799ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T12:30:30.878142Z","caller":"traceutil/trace.go:171","msg":"trace[1324074916] transaction","detail":"{read_only:false; response_revision:26316; number_of_response:1; }","duration":"189.324336ms","start":"2026-06-16T12:30:30.688723Z","end":"2026-06-16T12:30:30.878047Z","steps":["trace[1324074916] 'process raft request' (duration: 189.071071ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T12:30:30.878674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.827786ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:18353"} {"level":"info","ts":"2026-06-16T12:30:30.878783Z","caller":"traceutil/trace.go:171","msg":"trace[1571854624] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:26316; }","duration":"190.000899ms","start":"2026-06-16T12:30:30.688757Z","end":"2026-06-16T12:30:30.878758Z","steps":["trace[1571854624] 'agreement among raft nodes before linearized reading' (duration: 189.370508ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T12:30:31.09917Z","caller":"traceutil/trace.go:171","msg":"trace[457128122] transaction","detail":"{read_only:false; response_revision:26317; number_of_response:1; }","duration":"151.920903ms","start":"2026-06-16T12:30:30.947215Z","end":"2026-06-16T12:30:31.099136Z","steps":["trace[457128122] 'process raft request' (duration: 143.262348ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T12:30:31.112118Z","caller":"traceutil/trace.go:171","msg":"trace[1321416736] linearizableReadLoop","detail":"{readStateIndex:27198; appliedIndex:27195; }","duration":"139.200162ms","start":"2026-06-16T12:30:30.972888Z","end":"2026-06-16T12:30:31.112089Z","steps":["trace[1321416736] 'read index received' (duration: 117.60905ms)","trace[1321416736] 'applied index is now lower than readState.Index' (duration: 21.589662ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T12:30:31.112326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.404606ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-16T12:30:31.11238Z","caller":"traceutil/trace.go:171","msg":"trace[1462404931] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:26319; }","duration":"139.516807ms","start":"2026-06-16T12:30:30.972847Z","end":"2026-06-16T12:30:31.112364Z","steps":["trace[1462404931] 'agreement among raft nodes before linearized reading' (duration: 139.366824ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T12:30:31.112679Z","caller":"traceutil/trace.go:171","msg":"trace[1017480735] transaction","detail":"{read_only:false; response_revision:26318; number_of_response:1; }","duration":"164.728777ms","start":"2026-06-16T12:30:30.947914Z","end":"2026-06-16T12:30:31.112642Z","steps":["trace[1017480735] 'process raft request' (duration: 163.899021ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T12:30:31.112722Z","caller":"traceutil/trace.go:171","msg":"trace[1851850809] transaction","detail":"{read_only:false; response_revision:26319; number_of_response:1; }","duration":"164.281668ms","start":"2026-06-16T12:30:30.948402Z","end":"2026-06-16T12:30:31.112684Z","steps":["trace[1851850809] 'process raft request' (duration: 163.593835ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T12:30:36.041035Z","caller":"traceutil/trace.go:171","msg":"trace[20455687] linearizableReadLoop","detail":"{readStateIndex:27293; appliedIndex:27292; }","duration":"128.164391ms","start":"2026-06-16T12:30:35.912845Z","end":"2026-06-16T12:30:36.041009Z","steps":["trace[20455687] 'read index received' (duration: 127.935527ms)","trace[20455687] 'applied index is now lower than readState.Index' (duration: 227.804µs)"],"step_count":2} {"level":"warn","ts":"2026-06-16T12:30:36.041198Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.321873ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/probes/\" range_end:\"/registry/monitoring.coreos.com/probes0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-16T12:30:36.041234Z","caller":"traceutil/trace.go:171","msg":"trace[2010405416] range","detail":"{range_begin:/registry/monitoring.coreos.com/probes/; range_end:/registry/monitoring.coreos.com/probes0; response_count:0; response_revision:26413; }","duration":"128.426436ms","start":"2026-06-16T12:30:35.912796Z","end":"2026-06-16T12:30:36.041222Z","steps":["trace[2010405416] 'agreement among raft nodes before linearized reading' (duration: 128.335354ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T12:30:36.041222Z","caller":"traceutil/trace.go:171","msg":"trace[2043655092] transaction","detail":"{read_only:false; response_revision:26413; number_of_response:1; }","duration":"144.222886ms","start":"2026-06-16T12:30:35.896923Z","end":"2026-06-16T12:30:36.041146Z","steps":["trace[2043655092] 'process raft request' (duration: 143.927641ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T12:30:36.383335Z","caller":"traceutil/trace.go:171","msg":"trace[131660441] transaction","detail":"{read_only:false; response_revision:26414; number_of_response:1; }","duration":"128.027808ms","start":"2026-06-16T12:30:36.255247Z","end":"2026-06-16T12:30:36.383275Z","steps":["trace[131660441] 'process raft request' (duration: 127.817204ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T12:30:36.539499Z","caller":"traceutil/trace.go:171","msg":"trace[616748768] linearizableReadLoop","detail":"{readStateIndex:27295; appliedIndex:27294; }","duration":"156.258067ms","start":"2026-06-16T12:30:36.383209Z","end":"2026-06-16T12:30:36.539467Z","steps":["trace[616748768] 'read index received' (duration: 83.44791ms)","trace[616748768] 'applied index is now lower than readState.Index' (duration: 72.808927ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T12:30:36.539713Z","caller":"traceutil/trace.go:171","msg":"trace[556883600] transaction","detail":"{read_only:false; response_revision:26415; number_of_response:1; }","duration":"174.497302ms","start":"2026-06-16T12:30:36.365202Z","end":"2026-06-16T12:30:36.539699Z","steps":["trace[556883600] 'process raft request' (duration: 101.522002ms)","trace[556883600] 'compare' (duration: 72.300367ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T12:30:36.539755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.138886ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-16T12:30:36.539818Z","caller":"traceutil/trace.go:171","msg":"trace[1405411253] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:26415; }","duration":"163.247518ms","start":"2026-06-16T12:30:36.376554Z","end":"2026-06-16T12:30:36.539802Z","steps":["trace[1405411253] 'agreement among raft nodes before linearized reading' (duration: 163.126776ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T12:30:36.590937Z","caller":"traceutil/trace.go:171","msg":"trace[485599451] transaction","detail":"{read_only:false; response_revision:26417; number_of_response:1; }","duration":"191.903755ms","start":"2026-06-16T12:30:36.398971Z","end":"2026-06-16T12:30:36.590874Z","steps":["trace[485599451] 'process raft request' (duration: 191.822193ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T12:30:36.591214Z","caller":"traceutil/trace.go:171","msg":"trace[1948443194] transaction","detail":"{read_only:false; response_revision:26416; number_of_response:1; }","duration":"194.969403ms","start":"2026-06-16T12:30:36.396236Z","end":"2026-06-16T12:30:36.591205Z","steps":["trace[1948443194] 'process raft request' (duration: 194.429033ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T12:30:36.591273Z","caller":"traceutil/trace.go:171","msg":"trace[150826857] transaction","detail":"{read_only:false; response_revision:26418; number_of_response:1; }","duration":"192.231211ms","start":"2026-06-16T12:30:36.399018Z","end":"2026-06-16T12:30:36.591249Z","steps":["trace[150826857] 'process raft request' (duration: 191.818203ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T12:30:36.591639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.133414ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-16T12:30:36.591675Z","caller":"traceutil/trace.go:171","msg":"trace[1835066924] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26419; }","duration":"207.232166ms","start":"2026-06-16T12:30:36.384434Z","end":"2026-06-16T12:30:36.591666Z","steps":["trace[1835066924] 'agreement among raft nodes before linearized reading' (duration: 207.149285ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T12:30:36.591648Z","caller":"traceutil/trace.go:171","msg":"trace[849076839] transaction","detail":"{read_only:false; response_revision:26419; number_of_response:1; }","duration":"141.714908ms","start":"2026-06-16T12:30:36.449886Z","end":"2026-06-16T12:30:36.5916Z","steps":["trace[849076839] 'process raft request' (duration: 141.28431ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T12:30:36.591705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.336459ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-06-16T12:30:36.591754Z","caller":"traceutil/trace.go:171","msg":"trace[1108343281] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26419; }","duration":"175.451611ms","start":"2026-06-16T12:30:36.416287Z","end":"2026-06-16T12:30:36.591739Z","steps":["trace[1108343281] 'agreement among raft nodes before linearized reading' (duration: 175.288428ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T12:30:38.733932Z","caller":"traceutil/trace.go:171","msg":"trace[1791643662] transaction","detail":"{read_only:false; response_revision:26431; number_of_response:1; }","duration":"188.461119ms","start":"2026-06-16T12:30:38.545437Z","end":"2026-06-16T12:30:38.733898Z","steps":["trace[1791643662] 'process raft request' (duration: 188.127293ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T12:30:38.73455Z","caller":"traceutil/trace.go:171","msg":"trace[850316056] linearizableReadLoop","detail":"{readStateIndex:27314; appliedIndex:27310; }","duration":"107.355595ms","start":"2026-06-16T12:30:38.627163Z","end":"2026-06-16T12:30:38.734519Z","steps":["trace[850316056] 'read index received' (duration: 106.509339ms)","trace[850316056] 'applied index is now lower than readState.Index' (duration: 845.026µs)"],"step_count":2} {"level":"info","ts":"2026-06-16T12:30:38.734589Z","caller":"traceutil/trace.go:171","msg":"trace[1080225956] transaction","detail":"{read_only:false; response_revision:26432; number_of_response:1; }","duration":"136.969869ms","start":"2026-06-16T12:30:38.597583Z","end":"2026-06-16T12:30:38.734553Z","steps":["trace[1080225956] 'process raft request' (duration: 136.645703ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T12:30:38.734696Z","caller":"traceutil/trace.go:171","msg":"trace[262192825] transaction","detail":"{read_only:false; response_revision:26434; number_of_response:1; }","duration":"136.979059ms","start":"2026-06-16T12:30:38.597704Z","end":"2026-06-16T12:30:38.734683Z","steps":["trace[262192825] 'process raft request' (duration: 136.741315ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T12:30:38.734587Z","caller":"traceutil/trace.go:171","msg":"trace[1402713195] transaction","detail":"{read_only:false; response_revision:26433; number_of_response:1; }","duration":"136.921278ms","start":"2026-06-16T12:30:38.59765Z","end":"2026-06-16T12:30:38.734571Z","steps":["trace[1402713195] 'process raft request' (duration: 136.743755ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T12:30:38.734991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.802263ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1866"} {"level":"info","ts":"2026-06-16T12:30:38.735048Z","caller":"traceutil/trace.go:171","msg":"trace[918602982] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:26434; }","duration":"107.927846ms","start":"2026-06-16T12:30:38.627105Z","end":"2026-06-16T12:30:38.735033Z","steps":["trace[918602982] 'agreement among raft nodes before linearized reading' (duration: 107.740112ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T12:30:38.735146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.978184ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-06-16T12:30:38.735275Z","caller":"traceutil/trace.go:171","msg":"trace[488010694] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26434; }","duration":"101.153906ms","start":"2026-06-16T12:30:38.634093Z","end":"2026-06-16T12:30:38.735247Z","steps":["trace[488010694] 'agreement among raft nodes before linearized reading' (duration: 100.771929ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T12:30:43.214093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.517117ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-16T12:30:43.214276Z","caller":"traceutil/trace.go:171","msg":"trace[1858072757] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:26486; }","duration":"181.896114ms","start":"2026-06-16T12:30:43.032339Z","end":"2026-06-16T12:30:43.214235Z","steps":["trace[1858072757] 'count revisions from in-memory index tree' (duration: 181.400665ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T12:30:43.399464Z","caller":"traceutil/trace.go:171","msg":"trace[138702072] transaction","detail":"{read_only:false; response_revision:26489; number_of_response:1; }","duration":"246.80027ms","start":"2026-06-16T12:30:43.152628Z","end":"2026-06-16T12:30:43.399428Z","steps":["trace[138702072] 'process raft request' (duration: 246.548225ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T12:30:43.399469Z","caller":"traceutil/trace.go:171","msg":"trace[497934588] transaction","detail":"{read_only:false; response_revision:26488; number_of_response:1; }","duration":"249.607284ms","start":"2026-06-16T12:30:43.149813Z","end":"2026-06-16T12:30:43.399421Z","steps":["trace[497934588] 'process raft request' (duration: 213.023137ms)","trace[497934588] 'compare' (duration: 36.155398ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T12:30:43.699239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.024298ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackmachinetemplates/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackmachinetemplates0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-16T12:30:43.699312Z","caller":"traceutil/trace.go:171","msg":"trace[1610590333] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackmachinetemplates/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackmachinetemplates0; response_count:0; response_revision:26489; }","duration":"192.12322ms","start":"2026-06-16T12:30:43.507171Z","end":"2026-06-16T12:30:43.699294Z","steps":["trace[1610590333] 'count revisions from in-memory index tree' (duration: 191.876524ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T12:30:43.699484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.447494ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"info","ts":"2026-06-16T12:30:43.699507Z","caller":"traceutil/trace.go:171","msg":"trace[2012867639] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26489; }","duration":"111.488814ms","start":"2026-06-16T12:30:43.588013Z","end":"2026-06-16T12:30:43.699502Z","steps":["trace[2012867639] 'range keys from in-memory index tree' (duration: 111.356421ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T12:30:43.69957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.89027ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-06-16T12:30:43.699654Z","caller":"traceutil/trace.go:171","msg":"trace[1167089630] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26489; }","duration":"113.030593ms","start":"2026-06-16T12:30:43.586607Z","end":"2026-06-16T12:30:43.699638Z","steps":["trace[1167089630] 'range keys from in-memory index tree' (duration: 112.663047ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T12:30:43.699824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.093231ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-16T12:30:43.699911Z","caller":"traceutil/trace.go:171","msg":"trace[61331383] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26489; }","duration":"105.196953ms","start":"2026-06-16T12:30:43.594692Z","end":"2026-06-16T12:30:43.699889Z","steps":["trace[61331383] 'range keys from in-memory index tree' (duration: 104.945238ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T12:30:43.699825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.127795ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/addons.cluster.x-k8s.io/clusterresourcesetbindings/\" range_end:\"/registry/addons.cluster.x-k8s.io/clusterresourcesetbindings0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-16T12:30:43.700019Z","caller":"traceutil/trace.go:171","msg":"trace[1123950347] range","detail":"{range_begin:/registry/addons.cluster.x-k8s.io/clusterresourcesetbindings/; range_end:/registry/addons.cluster.x-k8s.io/clusterresourcesetbindings0; response_count:0; response_revision:26489; }","duration":"186.344589ms","start":"2026-06-16T12:30:43.513635Z","end":"2026-06-16T12:30:43.699979Z","steps":["trace[1123950347] 'count revisions from in-memory index tree' (duration: 186.051163ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T12:30:48.231885Z","caller":"traceutil/trace.go:171","msg":"trace[1258957166] transaction","detail":"{read_only:false; response_revision:26530; number_of_response:1; }","duration":"149.163711ms","start":"2026-06-16T12:30:48.082688Z","end":"2026-06-16T12:30:48.231851Z","steps":["trace[1258957166] 'process raft request' (duration: 148.973998ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T12:30:50.805365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.568216ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-16T12:30:50.805919Z","caller":"traceutil/trace.go:171","msg":"trace[183602718] transaction","detail":"{read_only:false; response_revision:26548; number_of_response:1; }","duration":"190.050239ms","start":"2026-06-16T12:30:50.615845Z","end":"2026-06-16T12:30:50.805895Z","steps":["trace[183602718] 'process raft request' (duration: 36.825401ms)","trace[183602718] 'compare' (duration: 152.376482ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T12:30:55.776585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.832175ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:30"} {"level":"info","ts":"2026-06-16T12:30:56.080315Z","caller":"traceutil/trace.go:171","msg":"trace[1265779849] transaction","detail":"{read_only:false; response_revision:26588; number_of_response:1; }","duration":"299.490593ms","start":"2026-06-16T12:30:55.780789Z","end":"2026-06-16T12:30:56.08028Z","steps":["trace[1265779849] 'process raft request' (duration: 299.287ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T12:30:56.086577Z","caller":"traceutil/trace.go:171","msg":"trace[705106977] transaction","detail":"{read_only:false; response_revision:26590; number_of_response:1; }","duration":"304.333955ms","start":"2026-06-16T12:30:55.782212Z","end":"2026-06-16T12:30:56.086546Z","steps":["trace[705106977] 'process raft request' (duration: 304.278704ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T12:30:56.086661Z","caller":"traceutil/trace.go:171","msg":"trace[517469464] transaction","detail":"{read_only:false; response_revision:26589; number_of_response:1; }","duration":"305.12898ms","start":"2026-06-16T12:30:55.781491Z","end":"2026-06-16T12:30:56.08662Z","steps":["trace[517469464] 'process raft request' (duration: 304.776294ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T12:30:56.086767Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T12:30:55.782204Z","time spent":"304.459537ms","remote":"127.0.0.1:32838","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-16T12:30:56.086855Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T12:30:55.781476Z","time spent":"305.274504ms","remote":"127.0.0.1:32838","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T12:31:04.245781Z","caller":"traceutil/trace.go:171","msg":"trace[1542546701] linearizableReadLoop","detail":"{readStateIndex:27545; appliedIndex:27544; }","duration":"123.457581ms","start":"2026-06-16T12:31:04.12229Z","end":"2026-06-16T12:31:04.245748Z","steps":["trace[1542546701] 'read index received' (duration: 123.205997ms)","trace[1542546701] 'applied index is now lower than readState.Index' (duration: 250.194µs)"],"step_count":2} {"level":"info","ts":"2026-06-16T12:31:04.245864Z","caller":"traceutil/trace.go:171","msg":"trace[2081033371] transaction","detail":"{read_only:false; response_revision:26660; number_of_response:1; }","duration":"124.99732ms","start":"2026-06-16T12:31:04.1208Z","end":"2026-06-16T12:31:04.245798Z","steps":["trace[2081033371] 'process raft request' (duration: 124.717985ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T12:31:04.246122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.783008ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-06-16T12:31:04.246237Z","caller":"traceutil/trace.go:171","msg":"trace[1009619374] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26660; }","duration":"123.932621ms","start":"2026-06-16T12:31:04.122276Z","end":"2026-06-16T12:31:04.246209Z","steps":["trace[1009619374] 'agreement among raft nodes before linearized reading' (duration: 123.601034ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T12:31:04.246334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.720657ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-06-16T12:31:04.2464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.705312ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:561"} {"level":"info","ts":"2026-06-16T12:31:04.246444Z","caller":"traceutil/trace.go:171","msg":"trace[1187068417] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26660; }","duration":"122.911762ms","start":"2026-06-16T12:31:04.123507Z","end":"2026-06-16T12:31:04.246419Z","steps":["trace[1187068417] 'agreement among raft nodes before linearized reading' (duration: 122.605926ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T12:31:04.246513Z","caller":"traceutil/trace.go:171","msg":"trace[1510840792] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:26660; }","duration":"106.890086ms","start":"2026-06-16T12:31:04.139596Z","end":"2026-06-16T12:31:04.246486Z","steps":["trace[1510840792] 'agreement among raft nodes before linearized reading' (duration: 106.542959ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T12:31:04.470956Z","caller":"traceutil/trace.go:171","msg":"trace[185567073] transaction","detail":"{read_only:false; response_revision:26661; number_of_response:1; }","duration":"219.903458ms","start":"2026-06-16T12:31:04.251Z","end":"2026-06-16T12:31:04.470903Z","steps":["trace[185567073] 'process raft request' (duration: 127.999138ms)","trace[185567073] 'compare' (duration: 91.384521ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T12:31:04.483723Z","caller":"traceutil/trace.go:171","msg":"trace[1115820158] transaction","detail":"{read_only:false; response_revision:26662; number_of_response:1; }","duration":"232.199983ms","start":"2026-06-16T12:31:04.251507Z","end":"2026-06-16T12:31:04.483706Z","steps":["trace[1115820158] 'process raft request' (duration: 232.02792ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T12:31:04.484124Z","caller":"traceutil/trace.go:171","msg":"trace[1987701551] transaction","detail":"{read_only:false; response_revision:26663; number_of_response:1; }","duration":"232.297664ms","start":"2026-06-16T12:31:04.251795Z","end":"2026-06-16T12:31:04.484092Z","steps":["trace[1987701551] 'process raft request' (duration: 231.865835ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T12:31:04.484312Z","caller":"traceutil/trace.go:171","msg":"trace[191156376] linearizableReadLoop","detail":"{readStateIndex:27549; appliedIndex:27545; }","duration":"156.42947ms","start":"2026-06-16T12:31:04.327866Z","end":"2026-06-16T12:31:04.484295Z","steps":["trace[191156376] 'read index received' (duration: 51.260937ms)","trace[191156376] 'applied index is now lower than readState.Index' (duration: 105.167603ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T12:31:04.484483Z","caller":"traceutil/trace.go:171","msg":"trace[2050198046] transaction","detail":"{read_only:false; response_revision:26664; number_of_response:1; }","duration":"173.183749ms","start":"2026-06-16T12:31:04.311289Z","end":"2026-06-16T12:31:04.484473Z","steps":["trace[2050198046] 'process raft request' (duration: 172.689739ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T12:31:04.484615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.734175ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-16T12:31:04.484654Z","caller":"traceutil/trace.go:171","msg":"trace[2126841693] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26664; }","duration":"156.848127ms","start":"2026-06-16T12:31:04.327795Z","end":"2026-06-16T12:31:04.484644Z","steps":["trace[2126841693] 'agreement among raft nodes before linearized reading' (duration: 156.771526ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T12:31:05.423624Z","caller":"traceutil/trace.go:171","msg":"trace[684420019] transaction","detail":"{read_only:false; response_revision:26673; number_of_response:1; }","duration":"101.884121ms","start":"2026-06-16T12:31:05.321703Z","end":"2026-06-16T12:31:05.423587Z","steps":["trace[684420019] 'process raft request' (duration: 101.419531ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T12:31:07.364457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.118844ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12217"} {"level":"info","ts":"2026-06-16T12:31:07.364556Z","caller":"traceutil/trace.go:171","msg":"trace[1757479701] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:26687; }","duration":"155.239136ms","start":"2026-06-16T12:31:07.2093Z","end":"2026-06-16T12:31:07.364539Z","steps":["trace[1757479701] 'range keys from in-memory index tree' (duration: 154.89626ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T12:31:13.3928Z","caller":"traceutil/trace.go:171","msg":"trace[233531731] linearizableReadLoop","detail":"{readStateIndex:27617; appliedIndex:27616; }","duration":"207.142755ms","start":"2026-06-16T12:31:13.185632Z","end":"2026-06-16T12:31:13.392775Z","steps":["trace[233531731] 'read index received' (duration: 206.835919ms)","trace[233531731] 'applied index is now lower than readState.Index' (duration: 305.706µs)"],"step_count":2} {"level":"info","ts":"2026-06-16T12:31:13.392893Z","caller":"traceutil/trace.go:171","msg":"trace[1311720154] transaction","detail":"{read_only:false; response_revision:26729; number_of_response:1; }","duration":"296.465005ms","start":"2026-06-16T12:31:13.096379Z","end":"2026-06-16T12:31:13.392844Z","steps":["trace[1311720154] 'process raft request' (duration: 296.19779ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T12:31:13.393133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.480073ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-06-16T12:31:13.393198Z","caller":"traceutil/trace.go:171","msg":"trace[585904929] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26729; }","duration":"207.613494ms","start":"2026-06-16T12:31:13.185565Z","end":"2026-06-16T12:31:13.393179Z","steps":["trace[585904929] 'agreement among raft nodes before linearized reading' (duration: 207.377099ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T12:31:17.116271Z","caller":"traceutil/trace.go:171","msg":"trace[25321195] transaction","detail":"{read_only:false; response_revision:26756; number_of_response:1; }","duration":"146.499201ms","start":"2026-06-16T12:31:16.969733Z","end":"2026-06-16T12:31:17.116232Z","steps":["trace[25321195] 'process raft request' (duration: 111.700838ms)","trace[25321195] 'compare' (duration: 34.490296ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T12:31:17.116337Z","caller":"traceutil/trace.go:171","msg":"trace[832127551] transaction","detail":"{read_only:false; response_revision:26757; number_of_response:1; }","duration":"146.425529ms","start":"2026-06-16T12:31:16.969863Z","end":"2026-06-16T12:31:17.116288Z","steps":["trace[832127551] 'process raft request' (duration: 146.256866ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T12:31:17.116563Z","caller":"traceutil/trace.go:171","msg":"trace[1025062506] transaction","detail":"{read_only:false; response_revision:26758; number_of_response:1; }","duration":"145.103674ms","start":"2026-06-16T12:31:16.971427Z","end":"2026-06-16T12:31:17.116531Z","steps":["trace[1025062506] 'process raft request' (duration: 144.744808ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T12:31:19.726499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.183514ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-16T12:31:19.726754Z","caller":"traceutil/trace.go:171","msg":"trace[734815121] transaction","detail":"{read_only:false; response_revision:26778; number_of_response:1; }","duration":"189.384556ms","start":"2026-06-16T12:31:19.537346Z","end":"2026-06-16T12:31:19.726731Z","steps":["trace[734815121] 'process raft request' (duration: 189.294674ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T12:31:19.72676Z","caller":"traceutil/trace.go:171","msg":"trace[256917469] transaction","detail":"{read_only:false; response_revision:26777; number_of_response:1; }","duration":"194.498434ms","start":"2026-06-16T12:31:19.532225Z","end":"2026-06-16T12:31:19.726724Z","steps":["trace[256917469] 'process raft request' (duration: 57.871513ms)","trace[256917469] 'compare' (duration: 135.971359ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T12:31:20.632987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.366556ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.238\" ","response":"range_response_count:1 size:140"} {"level":"info","ts":"2026-06-16T12:31:20.63307Z","caller":"traceutil/trace.go:171","msg":"trace[2134061234] range","detail":"{range_begin:/registry/masterleases/199.204.45.238; range_end:; response_count:1; response_revision:26779; }","duration":"158.514639ms","start":"2026-06-16T12:31:20.474537Z","end":"2026-06-16T12:31:20.633051Z","steps":["trace[2134061234] 'range keys from in-memory index tree' (duration: 158.161402ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T12:31:20.633069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.502109ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-16T12:31:20.633156Z","caller":"traceutil/trace.go:171","msg":"trace[606198868] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0; response_count:0; response_revision:26779; }","duration":"125.663382ms","start":"2026-06-16T12:31:20.50747Z","end":"2026-06-16T12:31:20.633133Z","steps":["trace[606198868] 'range keys from in-memory index tree' (duration: 125.352017ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T12:31:21.641769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.818359ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/schemareplications/\" range_end:\"/registry/rabbitmq.com/schemareplications0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-16T12:31:21.641847Z","caller":"traceutil/trace.go:171","msg":"trace[404827349] range","detail":"{range_begin:/registry/rabbitmq.com/schemareplications/; range_end:/registry/rabbitmq.com/schemareplications0; response_count:0; response_revision:26788; }","duration":"279.961912ms","start":"2026-06-16T12:31:21.361866Z","end":"2026-06-16T12:31:21.641828Z","steps":["trace[404827349] 'count revisions from in-memory index tree' (duration: 279.730268ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T12:31:21.641984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.443627ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-06-16T12:31:21.642104Z","caller":"traceutil/trace.go:171","msg":"trace[1702761845] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26788; }","duration":"190.60291ms","start":"2026-06-16T12:31:21.451472Z","end":"2026-06-16T12:31:21.642074Z","steps":["trace[1702761845] 'range keys from in-memory index tree' (duration: 190.164522ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T12:31:21.643277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.444417ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-16T12:31:21.643339Z","caller":"traceutil/trace.go:171","msg":"trace[121138616] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26788; }","duration":"315.558199ms","start":"2026-06-16T12:31:21.327763Z","end":"2026-06-16T12:31:21.643322Z","steps":["trace[121138616] 'range keys from in-memory index tree' (duration: 315.247644ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T12:31:21.643545Z","caller":"traceutil/trace.go:171","msg":"trace[1420384868] transaction","detail":"{read_only:false; response_revision:26789; number_of_response:1; }","duration":"165.936969ms","start":"2026-06-16T12:31:21.477562Z","end":"2026-06-16T12:31:21.643499Z","steps":["trace[1420384868] 'process raft request' (duration: 111.981642ms)","trace[1420384868] 'compare' (duration: 52.689753ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T12:31:21.643407Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T12:31:21.327739Z","time spent":"315.658232ms","remote":"127.0.0.1:60792","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":30,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-16T12:31:23.144423Z","caller":"traceutil/trace.go:171","msg":"trace[810919741] transaction","detail":"{read_only:false; response_revision:26802; number_of_response:1; }","duration":"128.200241ms","start":"2026-06-16T12:31:23.016208Z","end":"2026-06-16T12:31:23.144408Z","steps":["trace[810919741] 'process raft request' (duration: 127.893135ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T12:31:23.14434Z","caller":"traceutil/trace.go:171","msg":"trace[540435387] linearizableReadLoop","detail":"{readStateIndex:27692; appliedIndex:27691; }","duration":"107.764502ms","start":"2026-06-16T12:31:23.036553Z","end":"2026-06-16T12:31:23.144317Z","steps":["trace[540435387] 'read index received' (duration: 107.591619ms)","trace[540435387] 'applied index is now lower than readState.Index' (duration: 171.683µs)"],"step_count":2} {"level":"warn","ts":"2026-06-16T12:31:23.144613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.040628ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-16T12:31:23.144722Z","caller":"traceutil/trace.go:171","msg":"trace[454730027] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:26802; }","duration":"108.231291ms","start":"2026-06-16T12:31:23.036458Z","end":"2026-06-16T12:31:23.14469Z","steps":["trace[454730027] 'agreement among raft nodes before linearized reading' (duration: 108.038898ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T12:33:06.862438Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":24971} {"level":"info","ts":"2026-06-16T12:33:07.013188Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":24971,"took":"144.039633ms","hash":3343333368,"current-db-size-bytes":60690432,"current-db-size":"61 MB","current-db-size-in-use-bytes":36605952,"current-db-size-in-use":"37 MB"} {"level":"info","ts":"2026-06-16T12:33:07.013307Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3343333368,"revision":24971,"compact-revision":21884} {"level":"info","ts":"2026-06-16T12:35:09.485885Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"d7dbc9f5893cc1f6","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-16T12:35:09.490962Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003} {"level":"info","ts":"2026-06-16T12:35:09.49109Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003} {"level":"info","ts":"2026-06-16T12:38:06.869537Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":27807} {"level":"info","ts":"2026-06-16T12:38:07.008011Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":27807,"took":"133.439111ms","hash":133233616,"current-db-size-bytes":60690432,"current-db-size":"61 MB","current-db-size-in-use-bytes":33832960,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-06-16T12:38:07.008083Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":133233616,"revision":27807,"compact-revision":24971} {"level":"info","ts":"2026-06-16T12:43:06.884915Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":30447} {"level":"info","ts":"2026-06-16T12:43:07.027596Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":30447,"took":"135.139083ms","hash":3613398799,"current-db-size-bytes":60690432,"current-db-size":"61 MB","current-db-size-in-use-bytes":30543872,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-06-16T12:43:07.027693Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3613398799,"revision":30447,"compact-revision":27807} {"level":"info","ts":"2026-06-16T12:48:06.892295Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":32700} {"level":"info","ts":"2026-06-16T12:48:07.03736Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":32700,"took":"140.911232ms","hash":55142545,"current-db-size-bytes":61730816,"current-db-size":"62 MB","current-db-size-in-use-bytes":30220288,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-06-16T12:48:07.037451Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":55142545,"revision":32700,"compact-revision":30447} {"level":"info","ts":"2026-06-16T12:53:06.900206Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":34933} {"level":"info","ts":"2026-06-16T12:53:07.044222Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":34933,"took":"139.800481ms","hash":1993405357,"current-db-size-bytes":61730816,"current-db-size":"62 MB","current-db-size-in-use-bytes":31502336,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-06-16T12:53:07.044292Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1993405357,"revision":34933,"compact-revision":32700} {"level":"info","ts":"2026-06-16T12:56:26.973811Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"d7dbc9f5893cc1f6","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-16T12:56:26.97976Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004} {"level":"info","ts":"2026-06-16T12:56:26.97992Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004} {"level":"info","ts":"2026-06-16T12:58:06.907262Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":37232} {"level":"info","ts":"2026-06-16T12:58:07.032298Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":37232,"took":"119.361302ms","hash":1395129296,"current-db-size-bytes":62152704,"current-db-size":"62 MB","current-db-size-in-use-bytes":31895552,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-06-16T12:58:07.032362Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1395129296,"revision":37232,"compact-revision":34933} {"level":"info","ts":"2026-06-16T13:03:06.913629Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":39508} {"level":"info","ts":"2026-06-16T13:03:07.03945Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":39508,"took":"120.929402ms","hash":3942497276,"current-db-size-bytes":62152704,"current-db-size":"62 MB","current-db-size-in-use-bytes":31436800,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-06-16T13:03:07.039548Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3942497276,"revision":39508,"compact-revision":37232}