{"level":"warn","ts":"2026-03-06T00:33:19.887603Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-03-06T00:33:19.887686Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.169: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.169:2380","--initial-cluster=instance=https://199.204.45.169:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.169:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.169: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-03-06T00:33:19.887743Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-03-06T00:33:19.887751Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.169:2380"]} {"level":"info","ts":"2026-03-06T00:33:19.887771Z","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-03-06T00:33:19.888366Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.169:2379"]} {"level":"info","ts":"2026-03-06T00:33:19.888454Z","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.169:2380"],"listen-peer-urls":["https://199.204.45.169:2380"],"advertise-client-urls":["https://199.204.45.169:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.169:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.169: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-03-06T00:33:19.898663Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"10.014018ms"} {"level":"info","ts":"2026-03-06T00:33:19.904667Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"1c917701ce165bac","cluster-id":"bfb5247022b87cb1"} {"level":"info","ts":"2026-03-06T00:33:19.904775Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac switched to configuration voters=()"} {"level":"info","ts":"2026-03-06T00:33:19.904812Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac became follower at term 0"} {"level":"info","ts":"2026-03-06T00:33:19.904827Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 1c917701ce165bac [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-03-06T00:33:19.904858Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac became follower at term 1"} {"level":"info","ts":"2026-03-06T00:33:19.904908Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac switched to configuration voters=(2058557354321271724)"} {"level":"warn","ts":"2026-03-06T00:33:19.915623Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-03-06T00:33:19.917102Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-03-06T00:33:19.918599Z","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-03-06T00:33:19.92116Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"1c917701ce165bac","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-03-06T00:33:19.921425Z","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-03-06T00:33:19.92142Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"1c917701ce165bac","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-03-06T00:33:19.92155Z","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-03-06T00:33:19.92167Z","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-03-06T00:33:19.923556Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac switched to configuration voters=(2058557354321271724)"} {"level":"info","ts":"2026-03-06T00:33:19.924624Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"bfb5247022b87cb1","local-member-id":"1c917701ce165bac","added-peer-id":"1c917701ce165bac","added-peer-peer-urls":["https://199.204.45.169:2380"]} {"level":"info","ts":"2026-03-06T00:33:19.927409Z","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-03-06T00:33:19.927516Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.169:2380"} {"level":"info","ts":"2026-03-06T00:33:19.927594Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.169:2380"} {"level":"info","ts":"2026-03-06T00:33:19.927754Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"1c917701ce165bac","initial-advertise-peer-urls":["https://199.204.45.169:2380"],"listen-peer-urls":["https://199.204.45.169:2380"],"advertise-client-urls":["https://199.204.45.169:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.169:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-03-06T00:33:19.927788Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-03-06T00:33:20.806084Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac is starting a new election at term 1"} {"level":"info","ts":"2026-03-06T00:33:20.806158Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac became pre-candidate at term 1"} {"level":"info","ts":"2026-03-06T00:33:20.806218Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac received MsgPreVoteResp from 1c917701ce165bac at term 1"} {"level":"info","ts":"2026-03-06T00:33:20.806239Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac became candidate at term 2"} {"level":"info","ts":"2026-03-06T00:33:20.806256Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac received MsgVoteResp from 1c917701ce165bac at term 2"} {"level":"info","ts":"2026-03-06T00:33:20.806271Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac became leader at term 2"} {"level":"info","ts":"2026-03-06T00:33:20.806285Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 1c917701ce165bac elected leader 1c917701ce165bac at term 2"} {"level":"info","ts":"2026-03-06T00:33:20.807422Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"1c917701ce165bac","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.169:2379]}","request-path":"/0/members/1c917701ce165bac/attributes","cluster-id":"bfb5247022b87cb1","publish-timeout":"7s"} {"level":"info","ts":"2026-03-06T00:33:20.807432Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-03-06T00:33:20.807627Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-03-06T00:33:20.807762Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-03-06T00:33:20.807881Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-03-06T00:33:20.808673Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"bfb5247022b87cb1","local-member-id":"1c917701ce165bac","cluster-version":"3.5"} {"level":"info","ts":"2026-03-06T00:33:20.808815Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-03-06T00:33:20.80887Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-03-06T00:33:20.810525Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.169:2379"} {"level":"info","ts":"2026-03-06T00:33:20.810598Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-03-06T00:33:20.81291Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-03-06T00:33:46.886369Z","caller":"traceutil/trace.go:171","msg":"trace[420920043] linearizableReadLoop","detail":"{readStateIndex:481; appliedIndex:480; }","duration":"165.724408ms","start":"2026-03-06T00:33:46.720615Z","end":"2026-03-06T00:33:46.886339Z","steps":["trace[420920043] 'read index received' (duration: 165.606124ms)","trace[420920043] 'applied index is now lower than readState.Index' (duration: 117.194µs)"],"step_count":2} {"level":"info","ts":"2026-03-06T00:33:46.886454Z","caller":"traceutil/trace.go:171","msg":"trace[817217737] transaction","detail":"{read_only:false; response_revision:465; number_of_response:1; }","duration":"168.491912ms","start":"2026-03-06T00:33:46.717928Z","end":"2026-03-06T00:33:46.88642Z","steps":["trace[817217737] 'process raft request' (duration: 168.233535ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T00:33:46.886607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.935304ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" ","response":"range_response_count:3 size:12665"} {"level":"info","ts":"2026-03-06T00:33:46.886675Z","caller":"traceutil/trace.go:171","msg":"trace[1419986322] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:3; response_revision:465; }","duration":"166.071577ms","start":"2026-03-06T00:33:46.720585Z","end":"2026-03-06T00:33:46.886657Z","steps":["trace[1419986322] 'agreement among raft nodes before linearized reading' (duration: 165.907273ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T00:33:57.170677Z","caller":"traceutil/trace.go:171","msg":"trace[17260490] transaction","detail":"{read_only:false; response_revision:658; number_of_response:1; }","duration":"128.208014ms","start":"2026-03-06T00:33:57.042439Z","end":"2026-03-06T00:33:57.170647Z","steps":["trace[17260490] 'process raft request' (duration: 127.705871ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T00:33:57.361319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.045017ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-03-06T00:33:57.361444Z","caller":"traceutil/trace.go:171","msg":"trace[940226875] transaction","detail":"{read_only:false; response_revision:659; number_of_response:1; }","duration":"170.677165ms","start":"2026-03-06T00:33:57.190743Z","end":"2026-03-06T00:33:57.36142Z","steps":["trace[940226875] 'process raft request' (duration: 59.881018ms)","trace[940226875] 'compare' (duration: 109.863342ms)"],"step_count":2} {"level":"info","ts":"2026-03-06T00:33:57.763633Z","caller":"traceutil/trace.go:171","msg":"trace[1944978900] linearizableReadLoop","detail":"{readStateIndex:678; appliedIndex:677; }","duration":"198.469812ms","start":"2026-03-06T00:33:57.565102Z","end":"2026-03-06T00:33:57.763572Z","steps":["trace[1944978900] 'read index received' (duration: 197.969178ms)","trace[1944978900] 'applied index is now lower than readState.Index' (duration: 499.854µs)"],"step_count":2} {"level":"info","ts":"2026-03-06T00:33:57.763698Z","caller":"traceutil/trace.go:171","msg":"trace[2017323964] transaction","detail":"{read_only:false; response_revision:660; number_of_response:1; }","duration":"295.864968ms","start":"2026-03-06T00:33:57.467797Z","end":"2026-03-06T00:33:57.763662Z","steps":["trace[2017323964] 'process raft request' (duration: 295.476397ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T00:33:57.763917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.78851ms","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-03-06T00:33:57.763956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.884679ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-r2x7z\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-03-06T00:33:57.764009Z","caller":"traceutil/trace.go:171","msg":"trace[633521712] range","detail":"{range_begin:/registry/pods/kube-system/cilium-r2x7z; range_end:; response_count:1; response_revision:660; }","duration":"114.003693ms","start":"2026-03-06T00:33:57.649987Z","end":"2026-03-06T00:33:57.763991Z","steps":["trace[633521712] 'agreement among raft nodes before linearized reading' (duration: 113.769137ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T00:33:57.764009Z","caller":"traceutil/trace.go:171","msg":"trace[1874716365] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:660; }","duration":"198.931024ms","start":"2026-03-06T00:33:57.565056Z","end":"2026-03-06T00:33:57.763987Z","steps":["trace[1874716365] 'agreement among raft nodes before linearized reading' (duration: 198.687938ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T00:33:57.984957Z","caller":"traceutil/trace.go:171","msg":"trace[757873894] transaction","detail":"{read_only:false; response_revision:662; number_of_response:1; }","duration":"215.13605ms","start":"2026-03-06T00:33:57.76979Z","end":"2026-03-06T00:33:57.984926Z","steps":["trace[757873894] 'process raft request' (duration: 213.230618ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T00:33:57.985224Z","caller":"traceutil/trace.go:171","msg":"trace[346150697] transaction","detail":"{read_only:false; response_revision:664; number_of_response:1; }","duration":"203.920739ms","start":"2026-03-06T00:33:57.781244Z","end":"2026-03-06T00:33:57.985164Z","steps":["trace[346150697] 'process raft request' (duration: 203.846547ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T00:33:57.985225Z","caller":"traceutil/trace.go:171","msg":"trace[745830731] transaction","detail":"{read_only:false; response_revision:663; number_of_response:1; }","duration":"206.895359ms","start":"2026-03-06T00:33:57.778295Z","end":"2026-03-06T00:33:57.98519Z","steps":["trace[745830731] 'process raft request' (duration: 206.501698ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T00:35:14.338843Z","caller":"traceutil/trace.go:171","msg":"trace[1386503333] linearizableReadLoop","detail":"{readStateIndex:1665; appliedIndex:1664; }","duration":"265.481767ms","start":"2026-03-06T00:35:14.073329Z","end":"2026-03-06T00:35:14.338811Z","steps":["trace[1386503333] 'read index received' (duration: 265.175669ms)","trace[1386503333] 'applied index is now lower than readState.Index' (duration: 300.778µs)"],"step_count":2} {"level":"info","ts":"2026-03-06T00:35:14.338948Z","caller":"traceutil/trace.go:171","msg":"trace[1460435890] transaction","detail":"{read_only:false; response_revision:1603; number_of_response:1; }","duration":"280.247534ms","start":"2026-03-06T00:35:14.058662Z","end":"2026-03-06T00:35:14.338909Z","steps":["trace[1460435890] 'process raft request' (duration: 279.924055ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T00:35:14.339083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.864025ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-06T00:35:14.339135Z","caller":"traceutil/trace.go:171","msg":"trace[991397375] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1603; }","duration":"247.960037ms","start":"2026-03-06T00:35:14.091162Z","end":"2026-03-06T00:35:14.339122Z","steps":["trace[991397375] 'agreement among raft nodes before linearized reading' (duration: 247.857345ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T00:35:14.339281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.117621ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-03-06T00:35:14.339395Z","caller":"traceutil/trace.go:171","msg":"trace[1047274620] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1603; }","duration":"151.262436ms","start":"2026-03-06T00:35:14.18811Z","end":"2026-03-06T00:35:14.339372Z","steps":["trace[1047274620] 'agreement among raft nodes before linearized reading' (duration: 151.030329ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T00:35:14.339749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.398682ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:554"} {"level":"info","ts":"2026-03-06T00:35:14.339834Z","caller":"traceutil/trace.go:171","msg":"trace[636091656] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1603; }","duration":"266.519985ms","start":"2026-03-06T00:35:14.073281Z","end":"2026-03-06T00:35:14.339801Z","steps":["trace[636091656] 'agreement among raft nodes before linearized reading' (duration: 265.727063ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T00:35:14.74651Z","caller":"traceutil/trace.go:171","msg":"trace[1208938883] linearizableReadLoop","detail":"{readStateIndex:1674; appliedIndex:1673; }","duration":"127.835227ms","start":"2026-03-06T00:35:14.618646Z","end":"2026-03-06T00:35:14.746481Z","steps":["trace[1208938883] 'read index received' (duration: 102.411536ms)","trace[1208938883] 'applied index is now lower than readState.Index' (duration: 25.422401ms)"],"step_count":2} {"level":"info","ts":"2026-03-06T00:35:14.74658Z","caller":"traceutil/trace.go:171","msg":"trace[977108205] transaction","detail":"{read_only:false; response_revision:1612; number_of_response:1; }","duration":"135.100972ms","start":"2026-03-06T00:35:14.611438Z","end":"2026-03-06T00:35:14.746539Z","steps":["trace[977108205] 'process raft request' (duration: 109.582798ms)","trace[977108205] 'compare' (duration: 25.259247ms)"],"step_count":2} {"level":"warn","ts":"2026-03-06T00:35:14.746702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.028653ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-06T00:35:14.746785Z","caller":"traceutil/trace.go:171","msg":"trace[831101730] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:1612; }","duration":"128.189997ms","start":"2026-03-06T00:35:14.618577Z","end":"2026-03-06T00:35:14.746767Z","steps":["trace[831101730] 'agreement among raft nodes before linearized reading' (duration: 128.042183ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T00:36:07.999816Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.139925ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-03-06T00:36:07.999943Z","caller":"traceutil/trace.go:171","msg":"trace[587226805] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1922; }","duration":"242.31606ms","start":"2026-03-06T00:36:07.757602Z","end":"2026-03-06T00:36:07.999918Z","steps":["trace[587226805] 'range keys from in-memory index tree' (duration: 241.934559ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T00:36:07.999907Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.800249ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-03-06T00:36:08.000026Z","caller":"traceutil/trace.go:171","msg":"trace[1522080383] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1922; }","duration":"181.992404ms","start":"2026-03-06T00:36:07.818007Z","end":"2026-03-06T00:36:08Z","steps":["trace[1522080383] 'range keys from in-memory index tree' (duration: 181.586062ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T00:41:19.147024Z","caller":"traceutil/trace.go:171","msg":"trace[450998939] transaction","detail":"{read_only:false; response_revision:4553; number_of_response:1; }","duration":"166.261043ms","start":"2026-03-06T00:41:18.980734Z","end":"2026-03-06T00:41:19.146995Z","steps":["trace[450998939] 'process raft request' (duration: 166.091169ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T00:41:19.204114Z","caller":"traceutil/trace.go:171","msg":"trace[1147557379] linearizableReadLoop","detail":"{readStateIndex:4730; appliedIndex:4727; }","duration":"119.599786ms","start":"2026-03-06T00:41:19.084477Z","end":"2026-03-06T00:41:19.204076Z","steps":["trace[1147557379] 'read index received' (duration: 62.353817ms)","trace[1147557379] 'applied index is now lower than readState.Index' (duration: 57.244569ms)"],"step_count":2} {"level":"info","ts":"2026-03-06T00:41:19.204259Z","caller":"traceutil/trace.go:171","msg":"trace[312056434] transaction","detail":"{read_only:false; response_revision:4554; number_of_response:1; }","duration":"217.232695ms","start":"2026-03-06T00:41:18.986979Z","end":"2026-03-06T00:41:19.204212Z","steps":["trace[312056434] 'process raft request' (duration: 216.950097ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T00:41:19.204392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.793227ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-06T00:41:19.204451Z","caller":"traceutil/trace.go:171","msg":"trace[1581331745] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4554; }","duration":"111.939881ms","start":"2026-03-06T00:41:19.092495Z","end":"2026-03-06T00:41:19.204435Z","steps":["trace[1581331745] 'agreement among raft nodes before linearized reading' (duration: 111.796597ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T00:41:19.204449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.949955ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-plgsn-tls\" ","response":"range_response_count:1 size:2184"} {"level":"info","ts":"2026-03-06T00:41:19.204523Z","caller":"traceutil/trace.go:171","msg":"trace[631085535] range","detail":"{range_begin:/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-plgsn-tls; range_end:; response_count:1; response_revision:4554; }","duration":"120.09901ms","start":"2026-03-06T00:41:19.084403Z","end":"2026-03-06T00:41:19.204502Z","steps":["trace[631085535] 'agreement among raft nodes before linearized reading' (duration: 119.822952ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T00:41:37.363369Z","caller":"traceutil/trace.go:171","msg":"trace[334728846] transaction","detail":"{read_only:false; response_revision:4899; number_of_response:1; }","duration":"166.277695ms","start":"2026-03-06T00:41:37.197053Z","end":"2026-03-06T00:41:37.363331Z","steps":["trace[334728846] 'process raft request' (duration: 105.308565ms)","trace[334728846] 'compare' (duration: 59.942133ms)"],"step_count":2} {"level":"info","ts":"2026-03-06T00:41:37.502767Z","caller":"traceutil/trace.go:171","msg":"trace[1601983331] transaction","detail":"{read_only:false; response_revision:4900; number_of_response:1; }","duration":"128.098465ms","start":"2026-03-06T00:41:37.374625Z","end":"2026-03-06T00:41:37.502723Z","steps":["trace[1601983331] 'process raft request' (duration: 93.88349ms)","trace[1601983331] 'compare' (duration: 34.060081ms)"],"step_count":2} {"level":"info","ts":"2026-03-06T00:41:37.747464Z","caller":"traceutil/trace.go:171","msg":"trace[425393755] transaction","detail":"{read_only:false; response_revision:4902; number_of_response:1; }","duration":"372.16802ms","start":"2026-03-06T00:41:37.375258Z","end":"2026-03-06T00:41:37.747426Z","steps":["trace[425393755] 'process raft request' (duration: 371.981955ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T00:41:37.747862Z","caller":"traceutil/trace.go:171","msg":"trace[901941322] transaction","detail":"{read_only:false; response_revision:4903; number_of_response:1; }","duration":"372.448046ms","start":"2026-03-06T00:41:37.375375Z","end":"2026-03-06T00:41:37.747823Z","steps":["trace[901941322] 'process raft request' (duration: 371.950343ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T00:41:37.747923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.303863ms","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-03-06T00:41:37.747886Z","caller":"traceutil/trace.go:171","msg":"trace[841371740] transaction","detail":"{read_only:false; response_revision:4904; number_of_response:1; }","duration":"372.277692ms","start":"2026-03-06T00:41:37.375546Z","end":"2026-03-06T00:41:37.747824Z","steps":["trace[841371740] 'process raft request' (duration: 371.81828ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T00:41:37.747965Z","caller":"traceutil/trace.go:171","msg":"trace[1702608046] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4906; }","duration":"317.394277ms","start":"2026-03-06T00:41:37.430559Z","end":"2026-03-06T00:41:37.747954Z","steps":["trace[1702608046] 'agreement among raft nodes before linearized reading' (duration: 317.16573ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T00:41:37.748117Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T00:41:37.375336Z","time spent":"372.626692ms","remote":"127.0.0.1:47066","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1669,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-06T00:41:37.748094Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T00:41:37.430542Z","time spent":"317.541531ms","remote":"127.0.0.1:47056","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-03-06T00:41:37.748274Z","caller":"traceutil/trace.go:171","msg":"trace[1815422582] transaction","detail":"{read_only:false; response_revision:4901; number_of_response:1; }","duration":"373.354483ms","start":"2026-03-06T00:41:37.374905Z","end":"2026-03-06T00:41:37.748259Z","steps":["trace[1815422582] 'process raft request' (duration: 372.13212ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T00:41:37.748359Z","caller":"traceutil/trace.go:171","msg":"trace[1708798121] transaction","detail":"{read_only:false; response_revision:4905; number_of_response:1; }","duration":"371.114103ms","start":"2026-03-06T00:41:37.37719Z","end":"2026-03-06T00:41:37.748304Z","steps":["trace[1708798121] 'process raft request' (duration: 370.229899ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T00:41:37.748406Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T00:41:37.374883Z","time spent":"373.491636ms","remote":"127.0.0.1:47066","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1623,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-06T00:41:37.748474Z","caller":"traceutil/trace.go:171","msg":"trace[1255748951] transaction","detail":"{read_only:false; response_revision:4906; number_of_response:1; }","duration":"370.395853ms","start":"2026-03-06T00:41:37.378065Z","end":"2026-03-06T00:41:37.748461Z","steps":["trace[1255748951] 'process raft request' (duration: 369.407166ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T00:41:37.748507Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T00:41:37.377182Z","time spent":"371.257157ms","remote":"127.0.0.1:47228","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3873,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-06T00:41:37.748558Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T00:41:37.378056Z","time spent":"370.466586ms","remote":"127.0.0.1:47000","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4760,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-06T00:41:37.748127Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T00:41:37.375234Z","time spent":"372.412077ms","remote":"127.0.0.1:46994","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1131,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-06T00:41:37.747548Z","caller":"traceutil/trace.go:171","msg":"trace[951196717] linearizableReadLoop","detail":"{readStateIndex:5090; appliedIndex:5083; }","duration":"316.915953ms","start":"2026-03-06T00:41:37.430604Z","end":"2026-03-06T00:41:37.74752Z","steps":["trace[951196717] 'read index received' (duration: 37.920964ms)","trace[951196717] 'applied index is now lower than readState.Index' (duration: 278.993609ms)"],"step_count":2} {"level":"warn","ts":"2026-03-06T00:41:37.748168Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T00:41:37.375538Z","time spent":"372.477928ms","remote":"127.0.0.1:47100","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1409,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-06T00:41:50.522078Z","caller":"traceutil/trace.go:171","msg":"trace[2050287367] linearizableReadLoop","detail":"{readStateIndex:5266; appliedIndex:5265; }","duration":"116.753391ms","start":"2026-03-06T00:41:50.40529Z","end":"2026-03-06T00:41:50.522044Z","steps":["trace[2050287367] 'read index received' (duration: 116.529825ms)","trace[2050287367] 'applied index is now lower than readState.Index' (duration: 222.246µs)"],"step_count":2} {"level":"info","ts":"2026-03-06T00:41:50.522114Z","caller":"traceutil/trace.go:171","msg":"trace[518524684] transaction","detail":"{read_only:false; response_revision:5076; number_of_response:1; }","duration":"144.570715ms","start":"2026-03-06T00:41:50.377506Z","end":"2026-03-06T00:41:50.522077Z","steps":["trace[518524684] 'process raft request' (duration: 144.326598ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T00:41:50.522263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.962507ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-03-06T00:41:50.522316Z","caller":"traceutil/trace.go:171","msg":"trace[16963707] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5076; }","duration":"117.05837ms","start":"2026-03-06T00:41:50.405243Z","end":"2026-03-06T00:41:50.522301Z","steps":["trace[16963707] 'agreement among raft nodes before linearized reading' (duration: 116.864524ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T00:43:20.839285Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2773} {"level":"info","ts":"2026-03-06T00:43:20.898821Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2773,"took":"57.330737ms","hash":1393707091,"current-db-size-bytes":41848832,"current-db-size":"42 MB","current-db-size-in-use-bytes":31592448,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-03-06T00:43:20.898904Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1393707091,"revision":2773,"compact-revision":-1} {"level":"info","ts":"2026-03-06T00:45:45.310835Z","caller":"traceutil/trace.go:171","msg":"trace[815497914] transaction","detail":"{read_only:false; response_revision:6618; number_of_response:1; }","duration":"148.076762ms","start":"2026-03-06T00:45:45.162731Z","end":"2026-03-06T00:45:45.310808Z","steps":["trace[815497914] 'process raft request' (duration: 114.35169ms)","trace[815497914] 'compare' (duration: 33.567958ms)"],"step_count":2} {"level":"info","ts":"2026-03-06T00:47:34.987144Z","caller":"traceutil/trace.go:171","msg":"trace[1102911843] transaction","detail":"{read_only:false; response_revision:7531; number_of_response:1; }","duration":"242.118769ms","start":"2026-03-06T00:47:34.74498Z","end":"2026-03-06T00:47:34.987099Z","steps":["trace[1102911843] 'process raft request' (duration: 241.672718ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T00:47:46.772459Z","caller":"traceutil/trace.go:171","msg":"trace[1624102848] transaction","detail":"{read_only:false; response_revision:7584; number_of_response:1; }","duration":"106.967952ms","start":"2026-03-06T00:47:46.665463Z","end":"2026-03-06T00:47:46.772431Z","steps":["trace[1624102848] 'process raft request' (duration: 101.050614ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T00:47:48.125732Z","caller":"traceutil/trace.go:171","msg":"trace[2069312184] transaction","detail":"{read_only:false; response_revision:7590; number_of_response:1; }","duration":"100.460748ms","start":"2026-03-06T00:47:48.025242Z","end":"2026-03-06T00:47:48.125703Z","steps":["trace[2069312184] 'process raft request' (duration: 100.308144ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T00:48:17.022123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.759821ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-03-06T00:48:17.022321Z","caller":"traceutil/trace.go:171","msg":"trace[1536701454] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:7782; }","duration":"103.011858ms","start":"2026-03-06T00:48:16.919282Z","end":"2026-03-06T00:48:17.022293Z","steps":["trace[1536701454] 'range keys from in-memory index tree' (duration: 102.557006ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T00:48:17.022323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.931073ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-03-06T00:48:17.022429Z","caller":"traceutil/trace.go:171","msg":"trace[2132206873] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:7782; }","duration":"150.119999ms","start":"2026-03-06T00:48:16.872289Z","end":"2026-03-06T00:48:17.022409Z","steps":["trace[2132206873] 'range keys from in-memory index tree' (duration: 149.643426ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T00:48:20.850123Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5761} {"level":"info","ts":"2026-03-06T00:48:20.942845Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5761,"took":"90.37541ms","hash":2762017635,"current-db-size-bytes":44068864,"current-db-size":"44 MB","current-db-size-in-use-bytes":23003136,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-03-06T00:48:20.942932Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2762017635,"revision":5761,"compact-revision":2773} {"level":"info","ts":"2026-03-06T00:48:27.860845Z","caller":"traceutil/trace.go:171","msg":"trace[1291432268] linearizableReadLoop","detail":"{readStateIndex:8166; appliedIndex:8165; }","duration":"128.592172ms","start":"2026-03-06T00:48:27.732215Z","end":"2026-03-06T00:48:27.860807Z","steps":["trace[1291432268] 'read index received' (duration: 79.256311ms)","trace[1291432268] 'applied index is now lower than readState.Index' (duration: 49.333981ms)"],"step_count":2} {"level":"info","ts":"2026-03-06T00:48:27.860917Z","caller":"traceutil/trace.go:171","msg":"trace[1811812889] transaction","detail":"{read_only:false; response_revision:7877; number_of_response:1; }","duration":"211.379758ms","start":"2026-03-06T00:48:27.649481Z","end":"2026-03-06T00:48:27.860861Z","steps":["trace[1811812889] 'process raft request' (duration: 162.023926ms)","trace[1811812889] 'compare' (duration: 49.147956ms)"],"step_count":2} {"level":"warn","ts":"2026-03-06T00:48:27.861058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.803088ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-85czl\" ","response":"range_response_count:1 size:4648"} {"level":"info","ts":"2026-03-06T00:48:27.861173Z","caller":"traceutil/trace.go:171","msg":"trace[1547003248] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-85czl; range_end:; response_count:1; response_revision:7877; }","duration":"128.962372ms","start":"2026-03-06T00:48:27.732183Z","end":"2026-03-06T00:48:27.861146Z","steps":["trace[1547003248] 'agreement among raft nodes before linearized reading' (duration: 128.741847ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T00:48:27.864216Z","caller":"traceutil/trace.go:171","msg":"trace[1711798910] transaction","detail":"{read_only:false; response_revision:7878; number_of_response:1; }","duration":"131.026268ms","start":"2026-03-06T00:48:27.73317Z","end":"2026-03-06T00:48:27.864196Z","steps":["trace[1711798910] 'process raft request' (duration: 130.791662ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T00:48:28.521895Z","caller":"traceutil/trace.go:171","msg":"trace[1762193681] transaction","detail":"{read_only:false; response_revision:7882; number_of_response:1; }","duration":"246.715295ms","start":"2026-03-06T00:48:28.275155Z","end":"2026-03-06T00:48:28.52187Z","steps":["trace[1762193681] 'process raft request' (duration: 246.335175ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T00:48:29.292728Z","caller":"traceutil/trace.go:171","msg":"trace[776132443] transaction","detail":"{read_only:false; response_revision:7889; number_of_response:1; }","duration":"170.7174ms","start":"2026-03-06T00:48:29.121982Z","end":"2026-03-06T00:48:29.292699Z","steps":["trace[776132443] 'process raft request' (duration: 153.762126ms)","trace[776132443] 'compare' (duration: 16.691177ms)"],"step_count":2} {"level":"info","ts":"2026-03-06T00:48:29.292991Z","caller":"traceutil/trace.go:171","msg":"trace[1818960386] transaction","detail":"{read_only:false; response_revision:7890; number_of_response:1; }","duration":"170.918916ms","start":"2026-03-06T00:48:29.122029Z","end":"2026-03-06T00:48:29.292948Z","steps":["trace[1818960386] 'process raft request' (duration: 170.598947ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T00:48:29.58248Z","caller":"traceutil/trace.go:171","msg":"trace[459704312] transaction","detail":"{read_only:false; response_revision:7891; number_of_response:1; }","duration":"245.77913ms","start":"2026-03-06T00:48:29.336664Z","end":"2026-03-06T00:48:29.582443Z","steps":["trace[459704312] 'process raft request' (duration: 227.319985ms)","trace[459704312] 'compare' (duration: 18.29408ms)"],"step_count":2} {"level":"info","ts":"2026-03-06T00:52:14.0597Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"1c917701ce165bac","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-03-06T00:52:14.065651Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-03-06T00:52:14.065758Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-03-06T00:53:20.857557Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":7802} {"level":"info","ts":"2026-03-06T00:53:20.918526Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":7802,"took":"59.081483ms","hash":2968911733,"current-db-size-bytes":44068864,"current-db-size":"44 MB","current-db-size-in-use-bytes":27033600,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-03-06T00:53:20.918586Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2968911733,"revision":7802,"compact-revision":5761} {"level":"info","ts":"2026-03-06T00:58:20.863663Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10285} {"level":"info","ts":"2026-03-06T00:58:20.948004Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10285,"took":"80.106576ms","hash":1800861024,"current-db-size-bytes":44068864,"current-db-size":"44 MB","current-db-size-in-use-bytes":24330240,"current-db-size-in-use":"24 MB"} {"level":"info","ts":"2026-03-06T00:58:20.94809Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1800861024,"revision":10285,"compact-revision":7802} {"level":"info","ts":"2026-03-06T00:59:25.953575Z","caller":"traceutil/trace.go:171","msg":"trace[568030537] transaction","detail":"{read_only:false; response_revision:12575; number_of_response:1; }","duration":"118.876213ms","start":"2026-03-06T00:59:25.834671Z","end":"2026-03-06T00:59:25.953547Z","steps":["trace[568030537] 'process raft request' (duration: 118.726409ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T00:59:42.585798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.975824ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/openvswitch-7grb9\" ","response":"range_response_count:1 size:12599"} {"level":"info","ts":"2026-03-06T00:59:42.58594Z","caller":"traceutil/trace.go:171","msg":"trace[871710365] range","detail":"{range_begin:/registry/pods/openstack/openvswitch-7grb9; range_end:; response_count:1; response_revision:12668; }","duration":"259.209161ms","start":"2026-03-06T00:59:42.326702Z","end":"2026-03-06T00:59:42.585912Z","steps":["trace[871710365] 'range keys from in-memory index tree' (duration: 258.658066ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T00:59:42.586012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.280905ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-03-06T00:59:42.586111Z","caller":"traceutil/trace.go:171","msg":"trace[1456643933] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:12668; }","duration":"355.468359ms","start":"2026-03-06T00:59:42.230612Z","end":"2026-03-06T00:59:42.58608Z","steps":["trace[1456643933] 'range keys from in-memory index tree' (duration: 355.046768ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T00:59:42.586155Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T00:59:42.230576Z","time spent":"355.571192ms","remote":"127.0.0.1:47056","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-03-06T00:59:42.701652Z","caller":"traceutil/trace.go:171","msg":"trace[507086577] transaction","detail":"{read_only:false; response_revision:12669; number_of_response:1; }","duration":"212.020598ms","start":"2026-03-06T00:59:42.489592Z","end":"2026-03-06T00:59:42.701613Z","steps":["trace[507086577] 'process raft request' (duration: 211.784851ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T00:59:42.943475Z","caller":"traceutil/trace.go:171","msg":"trace[1651999257] linearizableReadLoop","detail":"{readStateIndex:13122; appliedIndex:13119; }","duration":"257.134086ms","start":"2026-03-06T00:59:42.686316Z","end":"2026-03-06T00:59:42.94345Z","steps":["trace[1651999257] 'read index received' (duration: 15.155245ms)","trace[1651999257] 'applied index is now lower than readState.Index' (duration: 241.977571ms)"],"step_count":2} {"level":"info","ts":"2026-03-06T00:59:42.943661Z","caller":"traceutil/trace.go:171","msg":"trace[1819760777] transaction","detail":"{read_only:false; response_revision:12671; number_of_response:1; }","duration":"344.067604ms","start":"2026-03-06T00:59:42.59956Z","end":"2026-03-06T00:59:42.943627Z","steps":["trace[1819760777] 'process raft request' (duration: 343.843368ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T00:59:42.94369Z","caller":"traceutil/trace.go:171","msg":"trace[880014782] transaction","detail":"{read_only:false; response_revision:12670; number_of_response:1; }","duration":"352.554881ms","start":"2026-03-06T00:59:42.591091Z","end":"2026-03-06T00:59:42.943646Z","steps":["trace[880014782] 'process raft request' (duration: 352.175371ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T00:59:42.943841Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T00:59:42.599536Z","time spent":"344.197527ms","remote":"127.0.0.1:47000","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":12713,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-06T00:59:42.943987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.602268ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12212"} {"level":"info","ts":"2026-03-06T00:59:42.944127Z","caller":"traceutil/trace.go:171","msg":"trace[1943172439] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:12671; }","duration":"257.855335ms","start":"2026-03-06T00:59:42.68624Z","end":"2026-03-06T00:59:42.944095Z","steps":["trace[1943172439] 'agreement among raft nodes before linearized reading' (duration: 257.423043ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T00:59:42.944348Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T00:59:42.591057Z","time spent":"352.729726ms","remote":"127.0.0.1:47056","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-06T00:59:42.944705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.072804ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-03-06T00:59:42.944766Z","caller":"traceutil/trace.go:171","msg":"trace[10161293] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:12672; }","duration":"201.163597ms","start":"2026-03-06T00:59:42.743589Z","end":"2026-03-06T00:59:42.944753Z","steps":["trace[10161293] 'agreement among raft nodes before linearized reading' (duration: 200.997103ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T00:59:42.944974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.740458ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-03-06T00:59:42.945053Z","caller":"traceutil/trace.go:171","msg":"trace[279334012] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:12672; }","duration":"193.899942ms","start":"2026-03-06T00:59:42.751135Z","end":"2026-03-06T00:59:42.945035Z","steps":["trace[279334012] 'agreement among raft nodes before linearized reading' (duration: 193.643906ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T00:59:48.692884Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000033a1.wal"} {"level":"warn","ts":"2026-03-06T01:01:19.663941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.336689ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-03-06T01:01:19.66403Z","caller":"traceutil/trace.go:171","msg":"trace[1177345260] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:13677; }","duration":"143.462351ms","start":"2026-03-06T01:01:19.52055Z","end":"2026-03-06T01:01:19.664013Z","steps":["trace[1177345260] 'count revisions from in-memory index tree' (duration: 143.281827ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T01:01:19.664131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.334565ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-03-06T01:01:19.664265Z","caller":"traceutil/trace.go:171","msg":"trace[1910881823] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:13677; }","duration":"228.5074ms","start":"2026-03-06T01:01:19.435735Z","end":"2026-03-06T01:01:19.664243Z","steps":["trace[1910881823] 'range keys from in-memory index tree' (duration: 228.15384ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T01:01:19.664323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.50339ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-06T01:01:19.664425Z","caller":"traceutil/trace.go:171","msg":"trace[1576868566] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:13677; }","duration":"200.644524ms","start":"2026-03-06T01:01:19.463756Z","end":"2026-03-06T01:01:19.6644Z","steps":["trace[1576868566] 'range keys from in-memory index tree' (duration: 200.430068ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T01:01:19.664406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.588451ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"warn","ts":"2026-03-06T01:01:19.664527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.891649ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5523"} {"level":"info","ts":"2026-03-06T01:01:19.664524Z","caller":"traceutil/trace.go:171","msg":"trace[535301030] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:13677; }","duration":"222.732175ms","start":"2026-03-06T01:01:19.441766Z","end":"2026-03-06T01:01:19.664498Z","steps":["trace[535301030] 'range keys from in-memory index tree' (duration: 222.466498ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T01:01:19.664558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.601743ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:667"} {"level":"info","ts":"2026-03-06T01:01:19.664574Z","caller":"traceutil/trace.go:171","msg":"trace[1503601101] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:13677; }","duration":"191.955221ms","start":"2026-03-06T01:01:19.472607Z","end":"2026-03-06T01:01:19.664562Z","steps":["trace[1503601101] 'range keys from in-memory index tree' (duration: 191.768856ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T01:01:19.664607Z","caller":"traceutil/trace.go:171","msg":"trace[1425672111] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:13677; }","duration":"200.663064ms","start":"2026-03-06T01:01:19.463928Z","end":"2026-03-06T01:01:19.664591Z","steps":["trace[1425672111] 'range keys from in-memory index tree' (duration: 200.52415ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T01:01:19.664632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.793023ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-03-06T01:01:19.664761Z","caller":"traceutil/trace.go:171","msg":"trace[2056007112] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:13677; }","duration":"224.003579ms","start":"2026-03-06T01:01:19.44074Z","end":"2026-03-06T01:01:19.664744Z","steps":["trace[2056007112] 'range keys from in-memory index tree' (duration: 223.632499ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T01:01:19.774832Z","caller":"traceutil/trace.go:171","msg":"trace[939232683] transaction","detail":"{read_only:false; response_revision:13679; number_of_response:1; }","duration":"105.268819ms","start":"2026-03-06T01:01:19.669539Z","end":"2026-03-06T01:01:19.774807Z","steps":["trace[939232683] 'process raft request' (duration: 105.083724ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T01:01:19.774993Z","caller":"traceutil/trace.go:171","msg":"trace[1989094799] transaction","detail":"{read_only:false; response_revision:13680; number_of_response:1; }","duration":"105.355451ms","start":"2026-03-06T01:01:19.669617Z","end":"2026-03-06T01:01:19.774973Z","steps":["trace[1989094799] 'process raft request' (duration: 105.142525ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T01:01:19.77514Z","caller":"traceutil/trace.go:171","msg":"trace[2145706488] transaction","detail":"{read_only:false; response_revision:13682; number_of_response:1; }","duration":"105.240418ms","start":"2026-03-06T01:01:19.669885Z","end":"2026-03-06T01:01:19.775125Z","steps":["trace[2145706488] 'process raft request' (duration: 105.170006ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T01:01:19.775222Z","caller":"traceutil/trace.go:171","msg":"trace[1894637463] transaction","detail":"{read_only:false; response_revision:13681; number_of_response:1; }","duration":"105.386552ms","start":"2026-03-06T01:01:19.669815Z","end":"2026-03-06T01:01:19.775202Z","steps":["trace[1894637463] 'process raft request' (duration: 105.092153ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T01:03:20.870481Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12187} {"level":"info","ts":"2026-03-06T01:03:20.942044Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12187,"took":"68.990608ms","hash":3963526165,"current-db-size-bytes":44068864,"current-db-size":"44 MB","current-db-size-in-use-bytes":27885568,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-03-06T01:03:20.942102Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3963526165,"revision":12187,"compact-revision":10285} {"level":"info","ts":"2026-03-06T01:06:46.406261Z","caller":"traceutil/trace.go:171","msg":"trace[261267498] transaction","detail":"{read_only:false; response_revision:16026; number_of_response:1; }","duration":"197.307804ms","start":"2026-03-06T01:06:46.208916Z","end":"2026-03-06T01:06:46.406224Z","steps":["trace[261267498] 'process raft request' (duration: 197.16349ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T01:06:46.437511Z","caller":"traceutil/trace.go:171","msg":"trace[233915636] linearizableReadLoop","detail":"{readStateIndex:16592; appliedIndex:16590; }","duration":"116.273163ms","start":"2026-03-06T01:06:46.321213Z","end":"2026-03-06T01:06:46.437486Z","steps":["trace[233915636] 'read index received' (duration: 84.894533ms)","trace[233915636] 'applied index is now lower than readState.Index' (duration: 31.37742ms)"],"step_count":2} {"level":"info","ts":"2026-03-06T01:06:46.437585Z","caller":"traceutil/trace.go:171","msg":"trace[1645138590] transaction","detail":"{read_only:false; response_revision:16027; number_of_response:1; }","duration":"124.894385ms","start":"2026-03-06T01:06:46.312649Z","end":"2026-03-06T01:06:46.437543Z","steps":["trace[1645138590] 'process raft request' (duration: 124.747261ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T01:06:46.437727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.486329ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-03-06T01:06:46.437788Z","caller":"traceutil/trace.go:171","msg":"trace[478694406] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:16027; }","duration":"116.604342ms","start":"2026-03-06T01:06:46.321171Z","end":"2026-03-06T01:06:46.437776Z","steps":["trace[478694406] 'agreement among raft nodes before linearized reading' (duration: 116.418247ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T01:08:20.876768Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14479} {"level":"info","ts":"2026-03-06T01:08:20.970288Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14479,"took":"90.39412ms","hash":3823585732,"current-db-size-bytes":45764608,"current-db-size":"46 MB","current-db-size-in-use-bytes":30048256,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-03-06T01:08:20.970357Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3823585732,"revision":14479,"compact-revision":12187} {"level":"info","ts":"2026-03-06T01:12:03.136592Z","caller":"traceutil/trace.go:171","msg":"trace[928722779] transaction","detail":"{read_only:false; response_revision:18390; number_of_response:1; }","duration":"141.688785ms","start":"2026-03-06T01:12:02.994877Z","end":"2026-03-06T01:12:03.136566Z","steps":["trace[928722779] 'process raft request' (duration: 141.592953ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T01:12:03.136629Z","caller":"traceutil/trace.go:171","msg":"trace[121235343] transaction","detail":"{read_only:false; response_revision:18389; number_of_response:1; }","duration":"141.965652ms","start":"2026-03-06T01:12:02.994626Z","end":"2026-03-06T01:12:03.136592Z","steps":["trace[121235343] 'process raft request' (duration: 134.699087ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T01:12:03.136889Z","caller":"traceutil/trace.go:171","msg":"trace[1289951212] transaction","detail":"{read_only:false; response_revision:18391; number_of_response:1; }","duration":"140.42422ms","start":"2026-03-06T01:12:02.996399Z","end":"2026-03-06T01:12:03.136823Z","steps":["trace[1289951212] 'process raft request' (duration: 140.121712ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T01:12:03.433271Z","caller":"traceutil/trace.go:171","msg":"trace[1517796855] transaction","detail":"{read_only:false; response_revision:18392; number_of_response:1; }","duration":"292.319879ms","start":"2026-03-06T01:12:03.140911Z","end":"2026-03-06T01:12:03.433231Z","steps":["trace[1517796855] 'process raft request' (duration: 210.660302ms)","trace[1517796855] 'compare' (duration: 81.546254ms)"],"step_count":2} {"level":"info","ts":"2026-03-06T01:12:03.881452Z","caller":"traceutil/trace.go:171","msg":"trace[975092608] transaction","detail":"{read_only:false; response_revision:18395; number_of_response:1; }","duration":"117.973729ms","start":"2026-03-06T01:12:03.763455Z","end":"2026-03-06T01:12:03.881429Z","steps":["trace[975092608] 'process raft request' (duration: 100.554573ms)","trace[975092608] 'compare' (duration: 17.303553ms)"],"step_count":2} {"level":"info","ts":"2026-03-06T01:13:20.886393Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":16937} {"level":"info","ts":"2026-03-06T01:13:20.997037Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":16937,"took":"106.679457ms","hash":3824686576,"current-db-size-bytes":45764608,"current-db-size":"46 MB","current-db-size-in-use-bytes":26370048,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-03-06T01:13:20.997111Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3824686576,"revision":16937,"compact-revision":14479} {"level":"info","ts":"2026-03-06T01:14:00.055242Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"1c917701ce165bac","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-03-06T01:14:00.062594Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-03-06T01:14:00.062682Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-03-06T01:15:34.271407Z","caller":"traceutil/trace.go:171","msg":"trace[1002544596] transaction","detail":"{read_only:false; response_revision:20571; number_of_response:1; }","duration":"104.116638ms","start":"2026-03-06T01:15:34.167256Z","end":"2026-03-06T01:15:34.271372Z","steps":["trace[1002544596] 'process raft request' (duration: 103.917413ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T01:15:34.5719Z","caller":"traceutil/trace.go:171","msg":"trace[100681034] linearizableReadLoop","detail":"{readStateIndex:21291; appliedIndex:21290; }","duration":"231.247812ms","start":"2026-03-06T01:15:34.340611Z","end":"2026-03-06T01:15:34.571859Z","steps":["trace[100681034] 'read index received' (duration: 229.071553ms)","trace[100681034] 'applied index is now lower than readState.Index' (duration: 2.174869ms)"],"step_count":2} {"level":"info","ts":"2026-03-06T01:15:34.571995Z","caller":"traceutil/trace.go:171","msg":"trace[62010070] transaction","detail":"{read_only:false; response_revision:20572; number_of_response:1; }","duration":"232.857065ms","start":"2026-03-06T01:15:34.339099Z","end":"2026-03-06T01:15:34.571956Z","steps":["trace[62010070] 'process raft request' (duration: 230.568344ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T01:15:34.572835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.203499ms","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-03-06T01:15:34.572914Z","caller":"traceutil/trace.go:171","msg":"trace[1926462640] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:20572; }","duration":"232.327412ms","start":"2026-03-06T01:15:34.340567Z","end":"2026-03-06T01:15:34.572895Z","steps":["trace[1926462640] 'agreement among raft nodes before linearized reading' (duration: 231.486239ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T01:15:34.593754Z","caller":"traceutil/trace.go:171","msg":"trace[740744631] transaction","detail":"{read_only:false; response_revision:20573; number_of_response:1; }","duration":"200.962722ms","start":"2026-03-06T01:15:34.392774Z","end":"2026-03-06T01:15:34.593737Z","steps":["trace[740744631] 'process raft request' (duration: 200.722965ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T01:15:34.594118Z","caller":"traceutil/trace.go:171","msg":"trace[1415299868] transaction","detail":"{read_only:false; response_revision:20574; number_of_response:1; }","duration":"104.028945ms","start":"2026-03-06T01:15:34.49007Z","end":"2026-03-06T01:15:34.594098Z","steps":["trace[1415299868] 'process raft request' (duration: 103.616144ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T01:15:34.594147Z","caller":"traceutil/trace.go:171","msg":"trace[2094742009] transaction","detail":"{read_only:false; response_revision:20575; number_of_response:1; }","duration":"103.474151ms","start":"2026-03-06T01:15:34.490651Z","end":"2026-03-06T01:15:34.594125Z","steps":["trace[2094742009] 'process raft request' (duration: 103.325497ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T01:15:34.594336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.692283ms","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-03-06T01:15:34.594388Z","caller":"traceutil/trace.go:171","msg":"trace[1658565672] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:20575; }","duration":"250.789745ms","start":"2026-03-06T01:15:34.343585Z","end":"2026-03-06T01:15:34.594375Z","steps":["trace[1658565672] 'agreement among raft nodes before linearized reading' (duration: 250.515338ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T01:18:20.896831Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19073} {"level":"info","ts":"2026-03-06T01:18:21.013184Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19073,"took":"110.256743ms","hash":3278675808,"current-db-size-bytes":48156672,"current-db-size":"48 MB","current-db-size-in-use-bytes":38739968,"current-db-size-in-use":"39 MB"} {"level":"info","ts":"2026-03-06T01:18:21.013265Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3278675808,"revision":19073,"compact-revision":16937} {"level":"info","ts":"2026-03-06T01:18:59.868164Z","caller":"traceutil/trace.go:171","msg":"trace[910833340] transaction","detail":"{read_only:false; response_revision:22520; number_of_response:1; }","duration":"107.142559ms","start":"2026-03-06T01:18:59.760992Z","end":"2026-03-06T01:18:59.868135Z","steps":["trace[910833340] 'process raft request' (duration: 105.466013ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T01:19:04.58866Z","caller":"traceutil/trace.go:171","msg":"trace[1580811588] transaction","detail":"{read_only:false; response_revision:22550; number_of_response:1; }","duration":"106.632275ms","start":"2026-03-06T01:19:04.481995Z","end":"2026-03-06T01:19:04.588627Z","steps":["trace[1580811588] 'process raft request' (duration: 106.249265ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T01:19:05.616084Z","caller":"traceutil/trace.go:171","msg":"trace[1464401521] transaction","detail":"{read_only:false; response_revision:22565; number_of_response:1; }","duration":"370.290495ms","start":"2026-03-06T01:19:05.245758Z","end":"2026-03-06T01:19:05.616048Z","steps":["trace[1464401521] 'process raft request' (duration: 370.053409ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T01:19:05.616341Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T01:19:05.24574Z","time spent":"370.470351ms","remote":"127.0.0.1:47056","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-06T01:19:05.740777Z","caller":"traceutil/trace.go:171","msg":"trace[518722680] transaction","detail":"{read_only:false; response_revision:22566; number_of_response:1; }","duration":"494.942403ms","start":"2026-03-06T01:19:05.245803Z","end":"2026-03-06T01:19:05.740745Z","steps":["trace[518722680] 'process raft request' (duration: 480.293991ms)","trace[518722680] 'compare' (duration: 14.332494ms)"],"step_count":2} {"level":"warn","ts":"2026-03-06T01:19:05.740995Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T01:19:05.245777Z","time spent":"495.100038ms","remote":"127.0.0.1:43702","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3851,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-06T01:19:05.741416Z","caller":"traceutil/trace.go:171","msg":"trace[148461870] transaction","detail":"{read_only:false; response_revision:22567; number_of_response:1; }","duration":"331.321783ms","start":"2026-03-06T01:19:05.410077Z","end":"2026-03-06T01:19:05.741399Z","steps":["trace[148461870] 'process raft request' (duration: 330.575493ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T01:19:05.741455Z","caller":"traceutil/trace.go:171","msg":"trace[48396202] transaction","detail":"{read_only:false; response_revision:22568; number_of_response:1; }","duration":"331.291863ms","start":"2026-03-06T01:19:05.410119Z","end":"2026-03-06T01:19:05.741411Z","steps":["trace[48396202] 'process raft request' (duration: 331.084737ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T01:19:05.741525Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T01:19:05.410044Z","time spent":"331.425696ms","remote":"127.0.0.1:47056","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-06T01:19:05.741524Z","caller":"traceutil/trace.go:171","msg":"trace[540425945] linearizableReadLoop","detail":"{readStateIndex:23343; appliedIndex:23339; }","duration":"252.43028ms","start":"2026-03-06T01:19:05.489078Z","end":"2026-03-06T01:19:05.741508Z","steps":["trace[540425945] 'read index received' (duration: 126.761805ms)","trace[540425945] 'applied index is now lower than readState.Index' (duration: 125.666955ms)"],"step_count":2} {"level":"warn","ts":"2026-03-06T01:19:05.741693Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T01:19:05.41009Z","time spent":"331.473988ms","remote":"127.0.0.1:47056","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-06T01:19:05.741773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.700127ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:562"} {"level":"info","ts":"2026-03-06T01:19:05.741832Z","caller":"traceutil/trace.go:171","msg":"trace[357825046] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:22569; }","duration":"252.803869ms","start":"2026-03-06T01:19:05.489016Z","end":"2026-03-06T01:19:05.741819Z","steps":["trace[357825046] 'agreement among raft nodes before linearized reading' (duration: 252.629115ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T01:19:09.910467Z","caller":"traceutil/trace.go:171","msg":"trace[73039513] transaction","detail":"{read_only:false; response_revision:22608; number_of_response:1; }","duration":"241.101067ms","start":"2026-03-06T01:19:09.669338Z","end":"2026-03-06T01:19:09.910439Z","steps":["trace[73039513] 'process raft request' (duration: 240.933582ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T01:19:10.184843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.060829ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-03-06T01:19:10.185361Z","caller":"traceutil/trace.go:171","msg":"trace[1455586072] transaction","detail":"{read_only:false; response_revision:22609; number_of_response:1; }","duration":"429.398068ms","start":"2026-03-06T01:19:09.755906Z","end":"2026-03-06T01:19:10.185304Z","steps":["trace[1455586072] 'process raft request' (duration: 287.752635ms)","trace[1455586072] 'compare' (duration: 140.856462ms)"],"step_count":2} {"level":"warn","ts":"2026-03-06T01:19:10.185553Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T01:19:09.755888Z","time spent":"429.561133ms","remote":"127.0.0.1:47056","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-06T01:19:10.185856Z","caller":"traceutil/trace.go:171","msg":"trace[314764561] transaction","detail":"{read_only:false; response_revision:22611; number_of_response:1; }","duration":"428.866664ms","start":"2026-03-06T01:19:09.756939Z","end":"2026-03-06T01:19:10.185806Z","steps":["trace[314764561] 'process raft request' (duration: 428.442603ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T01:19:10.185929Z","caller":"traceutil/trace.go:171","msg":"trace[1779015949] linearizableReadLoop","detail":"{readStateIndex:23387; appliedIndex:23384; }","duration":"423.330527ms","start":"2026-03-06T01:19:09.76245Z","end":"2026-03-06T01:19:10.185781Z","steps":["trace[1779015949] 'read index received' (duration: 148.922518ms)","trace[1779015949] 'applied index is now lower than readState.Index' (duration: 274.402899ms)"],"step_count":2} {"level":"warn","ts":"2026-03-06T01:19:10.186033Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T01:19:09.756932Z","time spent":"429.020588ms","remote":"127.0.0.1:47056","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-06T01:19:10.186228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"423.756168ms","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-03-06T01:19:10.186344Z","caller":"traceutil/trace.go:171","msg":"trace[1506471350] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:22611; }","duration":"423.931902ms","start":"2026-03-06T01:19:09.762386Z","end":"2026-03-06T01:19:10.186318Z","steps":["trace[1506471350] 'agreement among raft nodes before linearized reading' (duration: 423.630474ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T01:19:10.186393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T01:19:09.762364Z","time spent":"424.020055ms","remote":"127.0.0.1:47056","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":464,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-03-06T01:19:10.185452Z","caller":"traceutil/trace.go:171","msg":"trace[1155524718] transaction","detail":"{read_only:false; response_revision:22610; number_of_response:1; }","duration":"429.502942ms","start":"2026-03-06T01:19:09.755929Z","end":"2026-03-06T01:19:10.185432Z","steps":["trace[1155524718] 'process raft request' (duration: 429.315157ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T01:19:10.186563Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T01:19:09.75589Z","time spent":"430.548039ms","remote":"127.0.0.1:47056","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":498,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-06T01:19:10.186667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"423.179652ms","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-03-06T01:19:10.18677Z","caller":"traceutil/trace.go:171","msg":"trace[1067879514] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:22611; }","duration":"423.357487ms","start":"2026-03-06T01:19:09.763389Z","end":"2026-03-06T01:19:10.186746Z","steps":["trace[1067879514] 'agreement among raft nodes before linearized reading' (duration: 422.867194ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T01:19:10.186795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.7731ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:558"} {"level":"info","ts":"2026-03-06T01:19:10.186838Z","caller":"traceutil/trace.go:171","msg":"trace[931935164] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:22611; }","duration":"270.857672ms","start":"2026-03-06T01:19:09.915962Z","end":"2026-03-06T01:19:10.18682Z","steps":["trace[931935164] 'agreement among raft nodes before linearized reading' (duration: 270.76414ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T01:19:10.186849Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T01:19:09.763379Z","time spent":"423.45693ms","remote":"127.0.0.1:47056","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":505,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-03-06T01:19:10.186938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"410.647947ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ipam.cluster.x-k8s.io/ipaddressclaims/\" range_end:\"/registry/ipam.cluster.x-k8s.io/ipaddressclaims0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-03-06T01:19:10.186991Z","caller":"traceutil/trace.go:171","msg":"trace[961692348] range","detail":"{range_begin:/registry/ipam.cluster.x-k8s.io/ipaddressclaims/; range_end:/registry/ipam.cluster.x-k8s.io/ipaddressclaims0; response_count:0; response_revision:22611; }","duration":"410.708949ms","start":"2026-03-06T01:19:09.776262Z","end":"2026-03-06T01:19:10.186971Z","steps":["trace[961692348] 'agreement among raft nodes before linearized reading' (duration: 410.627726ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T01:19:10.187018Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T01:19:09.776254Z","time spent":"410.7586ms","remote":"127.0.0.1:42268","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":0,"response size":29,"request content":"key:\"/registry/ipam.cluster.x-k8s.io/ipaddressclaims/\" range_end:\"/registry/ipam.cluster.x-k8s.io/ipaddressclaims0\" count_only:true "} {"level":"warn","ts":"2026-03-06T01:19:10.187013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"419.099304ms","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-03-06T01:19:10.187086Z","caller":"traceutil/trace.go:171","msg":"trace[1207654911] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:22611; }","duration":"419.185566ms","start":"2026-03-06T01:19:09.767877Z","end":"2026-03-06T01:19:10.187063Z","steps":["trace[1207654911] 'agreement among raft nodes before linearized reading' (duration: 418.944098ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T01:19:10.187125Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T01:19:09.767873Z","time spent":"419.243317ms","remote":"127.0.0.1:47056","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-03-06T01:19:10.186999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"422.457284ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/machinehealthchecks/\" range_end:\"/registry/cluster.x-k8s.io/machinehealthchecks0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-03-06T01:19:10.187187Z","caller":"traceutil/trace.go:171","msg":"trace[261442208] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machinehealthchecks/; range_end:/registry/cluster.x-k8s.io/machinehealthchecks0; response_count:0; response_revision:22611; }","duration":"422.698489ms","start":"2026-03-06T01:19:09.764464Z","end":"2026-03-06T01:19:10.187163Z","steps":["trace[261442208] 'agreement among raft nodes before linearized reading' (duration: 422.417211ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T01:19:10.18723Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T01:19:09.764456Z","time spent":"422.763631ms","remote":"127.0.0.1:42234","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":29,"request content":"key:\"/registry/cluster.x-k8s.io/machinehealthchecks/\" range_end:\"/registry/cluster.x-k8s.io/machinehealthchecks0\" count_only:true "} {"level":"info","ts":"2026-03-06T01:19:14.273273Z","caller":"traceutil/trace.go:171","msg":"trace[6558798] transaction","detail":"{read_only:false; response_revision:22635; number_of_response:1; }","duration":"161.007391ms","start":"2026-03-06T01:19:14.11223Z","end":"2026-03-06T01:19:14.273237Z","steps":["trace[6558798] 'process raft request' (duration: 149.803211ms)","trace[6558798] 'compare' (duration: 11.031125ms)"],"step_count":2} {"level":"warn","ts":"2026-03-06T01:19:14.691441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.345565ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-03-06T01:19:14.691736Z","caller":"traceutil/trace.go:171","msg":"trace[741406915] transaction","detail":"{read_only:false; response_revision:22641; number_of_response:1; }","duration":"389.445259ms","start":"2026-03-06T01:19:14.302272Z","end":"2026-03-06T01:19:14.691718Z","steps":["trace[741406915] 'process raft request' (duration: 389.303045ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T01:19:14.691761Z","caller":"traceutil/trace.go:171","msg":"trace[1101575439] transaction","detail":"{read_only:false; response_revision:22640; number_of_response:1; }","duration":"389.654606ms","start":"2026-03-06T01:19:14.302067Z","end":"2026-03-06T01:19:14.691722Z","steps":["trace[1101575439] 'process raft request' (duration: 120.92904ms)","trace[1101575439] 'compare' (duration: 267.906593ms)"],"step_count":2} {"level":"warn","ts":"2026-03-06T01:19:14.691811Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T01:19:14.302229Z","time spent":"389.543911ms","remote":"127.0.0.1:47056","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":539,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-06T01:19:14.691919Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T01:19:14.30205Z","time spent":"389.779189ms","remote":"127.0.0.1:47056","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-06T01:19:14.692354Z","caller":"traceutil/trace.go:171","msg":"trace[703147247] transaction","detail":"{read_only:false; response_revision:22642; number_of_response:1; }","duration":"389.48365ms","start":"2026-03-06T01:19:14.302856Z","end":"2026-03-06T01:19:14.692339Z","steps":["trace[703147247] 'process raft request' (duration: 388.820433ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T01:19:14.692434Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T01:19:14.302846Z","time spent":"389.546192ms","remote":"127.0.0.1:47056","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-06T01:19:14.693572Z","caller":"traceutil/trace.go:171","msg":"trace[276056903] linearizableReadLoop","detail":"{readStateIndex:23420; appliedIndex:23416; }","duration":"197.279752ms","start":"2026-03-06T01:19:14.496005Z","end":"2026-03-06T01:19:14.693284Z","steps":["trace[276056903] 'read index received' (duration: 195.468543ms)","trace[276056903] 'applied index is now lower than readState.Index' (duration: 1.808199ms)"],"step_count":2} {"level":"info","ts":"2026-03-06T01:19:14.693776Z","caller":"traceutil/trace.go:171","msg":"trace[128196898] transaction","detail":"{read_only:false; response_revision:22643; number_of_response:1; }","duration":"390.424655ms","start":"2026-03-06T01:19:14.303296Z","end":"2026-03-06T01:19:14.69372Z","steps":["trace[128196898] 'process raft request' (duration: 388.690699ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T01:19:14.693863Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T01:19:14.303278Z","time spent":"390.542999ms","remote":"127.0.0.1:47056","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-06T01:19:14.693864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.817477ms","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-03-06T01:19:14.693924Z","caller":"traceutil/trace.go:171","msg":"trace[274260252] 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:22643; }","duration":"197.958431ms","start":"2026-03-06T01:19:14.495946Z","end":"2026-03-06T01:19:14.693905Z","steps":["trace[274260252] 'agreement among raft nodes before linearized reading' (duration: 197.804427ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T01:19:14.696357Z","caller":"traceutil/trace.go:171","msg":"trace[688358974] transaction","detail":"{read_only:false; response_revision:22644; number_of_response:1; }","duration":"169.16623ms","start":"2026-03-06T01:19:14.527168Z","end":"2026-03-06T01:19:14.696334Z","steps":["trace[688358974] 'process raft request' (duration: 168.827501ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T01:19:14.696373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.13112ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"info","ts":"2026-03-06T01:19:14.696424Z","caller":"traceutil/trace.go:171","msg":"trace[1410134431] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:22645; }","duration":"184.221593ms","start":"2026-03-06T01:19:14.51219Z","end":"2026-03-06T01:19:14.696412Z","steps":["trace[1410134431] 'agreement among raft nodes before linearized reading' (duration: 184.022298ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T01:19:14.696624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.263664ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/servicemonitors/\" range_end:\"/registry/monitoring.coreos.com/servicemonitors0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-03-06T01:19:14.69677Z","caller":"traceutil/trace.go:171","msg":"trace[1391317277] range","detail":"{range_begin:/registry/monitoring.coreos.com/servicemonitors/; range_end:/registry/monitoring.coreos.com/servicemonitors0; response_count:0; response_revision:22645; }","duration":"100.485022ms","start":"2026-03-06T01:19:14.596251Z","end":"2026-03-06T01:19:14.696736Z","steps":["trace[1391317277] 'agreement among raft nodes before linearized reading' (duration: 100.04382ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T01:19:15.519999Z","caller":"traceutil/trace.go:171","msg":"trace[565260738] transaction","detail":"{read_only:false; response_revision:22647; number_of_response:1; }","duration":"123.25392ms","start":"2026-03-06T01:19:15.396718Z","end":"2026-03-06T01:19:15.519972Z","steps":["trace[565260738] 'process raft request' (duration: 123.093056ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T01:19:15.727163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.507754ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/routerinterfaces/\" range_end:\"/registry/openstack.k-orc.cloud/routerinterfaces0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-03-06T01:19:15.727227Z","caller":"traceutil/trace.go:171","msg":"trace[1038373804] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/routerinterfaces/; range_end:/registry/openstack.k-orc.cloud/routerinterfaces0; response_count:0; response_revision:22647; }","duration":"121.622457ms","start":"2026-03-06T01:19:15.605588Z","end":"2026-03-06T01:19:15.727211Z","steps":["trace[1038373804] 'count revisions from in-memory index tree' (duration: 121.338259ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T01:19:15.727218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.332024ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanetemplates/\" range_end:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanetemplates0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-03-06T01:19:15.727291Z","caller":"traceutil/trace.go:171","msg":"trace[968187177] range","detail":"{range_begin:/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanetemplates/; range_end:/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanetemplates0; response_count:0; response_revision:22647; }","duration":"129.449957ms","start":"2026-03-06T01:19:15.597824Z","end":"2026-03-06T01:19:15.727274Z","steps":["trace[968187177] 'count revisions from in-memory index tree' (duration: 129.251871ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T01:19:15.727426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.385099ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1936"} {"level":"info","ts":"2026-03-06T01:19:15.72754Z","caller":"traceutil/trace.go:171","msg":"trace[250340354] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:22647; }","duration":"131.700087ms","start":"2026-03-06T01:19:15.595816Z","end":"2026-03-06T01:19:15.727516Z","steps":["trace[250340354] 'range keys from in-memory index tree' (duration: 131.088991ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T01:19:16.4858Z","caller":"traceutil/trace.go:171","msg":"trace[1433420639] transaction","detail":"{read_only:false; response_revision:22650; number_of_response:1; }","duration":"181.438799ms","start":"2026-03-06T01:19:16.304339Z","end":"2026-03-06T01:19:16.485778Z","steps":["trace[1433420639] 'process raft request' (duration: 176.683351ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T01:19:16.486012Z","caller":"traceutil/trace.go:171","msg":"trace[192789003] transaction","detail":"{read_only:false; response_revision:22651; number_of_response:1; }","duration":"181.243114ms","start":"2026-03-06T01:19:16.30476Z","end":"2026-03-06T01:19:16.486003Z","steps":["trace[192789003] 'process raft request' (duration: 180.982157ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T01:19:16.486482Z","caller":"traceutil/trace.go:171","msg":"trace[2094219609] transaction","detail":"{read_only:false; response_revision:22652; number_of_response:1; }","duration":"181.616383ms","start":"2026-03-06T01:19:16.304834Z","end":"2026-03-06T01:19:16.486451Z","steps":["trace[2094219609] 'process raft request' (duration: 181.11953ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T01:19:16.902369Z","caller":"traceutil/trace.go:171","msg":"trace[1893216256] linearizableReadLoop","detail":"{readStateIndex:23430; appliedIndex:23429; }","duration":"146.951025ms","start":"2026-03-06T01:19:16.755396Z","end":"2026-03-06T01:19:16.902347Z","steps":["trace[1893216256] 'read index received' (duration: 146.463672ms)","trace[1893216256] 'applied index is now lower than readState.Index' (duration: 486.463µs)"],"step_count":2} {"level":"info","ts":"2026-03-06T01:19:16.902525Z","caller":"traceutil/trace.go:171","msg":"trace[191123721] transaction","detail":"{read_only:false; response_revision:22653; number_of_response:1; }","duration":"200.002356ms","start":"2026-03-06T01:19:16.702489Z","end":"2026-03-06T01:19:16.902491Z","steps":["trace[191123721] 'process raft request' (duration: 199.481082ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T01:19:16.902633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.209542ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"info","ts":"2026-03-06T01:19:16.902722Z","caller":"traceutil/trace.go:171","msg":"trace[740475746] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:22653; }","duration":"147.352566ms","start":"2026-03-06T01:19:16.755346Z","end":"2026-03-06T01:19:16.902699Z","steps":["trace[740475746] 'agreement among raft nodes before linearized reading' (duration: 147.09926ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T01:19:16.927874Z","caller":"traceutil/trace.go:171","msg":"trace[1017952702] transaction","detail":"{read_only:false; response_revision:22654; number_of_response:1; }","duration":"159.235385ms","start":"2026-03-06T01:19:16.768601Z","end":"2026-03-06T01:19:16.927836Z","steps":["trace[1017952702] 'process raft request' (duration: 159.007979ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T01:19:16.928178Z","caller":"traceutil/trace.go:171","msg":"trace[317593123] transaction","detail":"{read_only:false; response_revision:22655; number_of_response:1; }","duration":"159.291746ms","start":"2026-03-06T01:19:16.768854Z","end":"2026-03-06T01:19:16.928146Z","steps":["trace[317593123] 'process raft request' (duration: 158.921416ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T01:19:16.928287Z","caller":"traceutil/trace.go:171","msg":"trace[1123368567] transaction","detail":"{read_only:false; response_revision:22657; number_of_response:1; }","duration":"158.023302ms","start":"2026-03-06T01:19:16.770232Z","end":"2026-03-06T01:19:16.928256Z","steps":["trace[1123368567] 'process raft request' (duration: 157.95659ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T01:19:16.928312Z","caller":"traceutil/trace.go:171","msg":"trace[965560235] transaction","detail":"{read_only:false; response_revision:22656; number_of_response:1; }","duration":"159.013449ms","start":"2026-03-06T01:19:16.769237Z","end":"2026-03-06T01:19:16.92825Z","steps":["trace[965560235] 'process raft request' (duration: 158.816093ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T01:19:17.110209Z","caller":"traceutil/trace.go:171","msg":"trace[1158755957] transaction","detail":"{read_only:false; response_revision:22658; number_of_response:1; }","duration":"203.306165ms","start":"2026-03-06T01:19:16.906878Z","end":"2026-03-06T01:19:17.110184Z","steps":["trace[1158755957] 'process raft request' (duration: 189.029032ms)","trace[1158755957] 'compare' (duration: 13.866992ms)"],"step_count":2} {"level":"warn","ts":"2026-03-06T01:19:17.337878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.638454ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5684"} {"level":"info","ts":"2026-03-06T01:19:17.337991Z","caller":"traceutil/trace.go:171","msg":"trace[1204825415] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:22659; }","duration":"122.804169ms","start":"2026-03-06T01:19:17.21516Z","end":"2026-03-06T01:19:17.337964Z","steps":["trace[1204825415] 'range keys from in-memory index tree' (duration: 122.356047ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T01:19:18.304887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.462823ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-03-06T01:19:18.305329Z","caller":"traceutil/trace.go:171","msg":"trace[130620069] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:22661; }","duration":"105.958857ms","start":"2026-03-06T01:19:18.199349Z","end":"2026-03-06T01:19:18.305308Z","steps":["trace[130620069] 'count revisions from in-memory index tree' (duration: 105.362341ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T01:19:18.606249Z","caller":"traceutil/trace.go:171","msg":"trace[1888312740] transaction","detail":"{read_only:false; response_revision:22663; number_of_response:1; }","duration":"114.725342ms","start":"2026-03-06T01:19:18.491481Z","end":"2026-03-06T01:19:18.606207Z","steps":["trace[1888312740] 'process raft request' (duration: 112.342428ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T01:19:18.824445Z","caller":"traceutil/trace.go:171","msg":"trace[1480964409] transaction","detail":"{read_only:false; response_revision:22665; number_of_response:1; }","duration":"332.083873ms","start":"2026-03-06T01:19:18.492334Z","end":"2026-03-06T01:19:18.824418Z","steps":["trace[1480964409] 'process raft request' (duration: 331.9547ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T01:19:18.824478Z","caller":"traceutil/trace.go:171","msg":"trace[324662894] transaction","detail":"{read_only:false; response_revision:22664; number_of_response:1; }","duration":"332.677779ms","start":"2026-03-06T01:19:18.491759Z","end":"2026-03-06T01:19:18.824437Z","steps":["trace[324662894] 'process raft request' (duration: 285.948377ms)","trace[324662894] 'compare' (duration: 46.332081ms)"],"step_count":2} {"level":"warn","ts":"2026-03-06T01:19:18.824596Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T01:19:18.492324Z","time spent":"332.193097ms","remote":"127.0.0.1:47056","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-06T01:19:18.824654Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T01:19:18.491741Z","time spent":"332.816423ms","remote":"127.0.0.1:47056","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-06T01:19:19.119131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.695805ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-03-06T01:19:19.119237Z","caller":"traceutil/trace.go:171","msg":"trace[1585571940] linearizableReadLoop","detail":"{readStateIndex:23443; appliedIndex:23442; }","duration":"187.995944ms","start":"2026-03-06T01:19:18.931224Z","end":"2026-03-06T01:19:19.11922Z","steps":["trace[1585571940] 'read index received' (duration: 5.99575ms)","trace[1585571940] 'applied index is now lower than readState.Index' (duration: 181.998924ms)"],"step_count":2} {"level":"info","ts":"2026-03-06T01:19:19.119305Z","caller":"traceutil/trace.go:171","msg":"trace[1348395984] transaction","detail":"{read_only:false; response_revision:22666; number_of_response:1; }","duration":"210.712782ms","start":"2026-03-06T01:19:18.908579Z","end":"2026-03-06T01:19:19.119292Z","steps":["trace[1348395984] 'process raft request' (duration: 28.76915ms)","trace[1348395984] 'compare' (duration: 181.558452ms)"],"step_count":2} {"level":"warn","ts":"2026-03-06T01:19:19.119554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.307102ms","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-03-06T01:19:19.119659Z","caller":"traceutil/trace.go:171","msg":"trace[2048599041] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:22666; }","duration":"188.463416ms","start":"2026-03-06T01:19:18.931174Z","end":"2026-03-06T01:19:19.119637Z","steps":["trace[2048599041] 'agreement among raft nodes before linearized reading' (duration: 188.127787ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T01:19:19.299288Z","caller":"traceutil/trace.go:171","msg":"trace[2037629128] transaction","detail":"{read_only:false; response_revision:22668; number_of_response:1; }","duration":"175.941601ms","start":"2026-03-06T01:19:19.123318Z","end":"2026-03-06T01:19:19.299259Z","steps":["trace[2037629128] 'process raft request' (duration: 175.870939ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T01:19:19.299291Z","caller":"traceutil/trace.go:171","msg":"trace[1926464534] linearizableReadLoop","detail":"{readStateIndex:23444; appliedIndex:23443; }","duration":"179.98835ms","start":"2026-03-06T01:19:19.119257Z","end":"2026-03-06T01:19:19.299245Z","steps":["trace[1926464534] 'read index received' (duration: 141.107619ms)","trace[1926464534] 'applied index is now lower than readState.Index' (duration: 38.877971ms)"],"step_count":2} {"level":"warn","ts":"2026-03-06T01:19:19.299573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"366.523945ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:558"} {"level":"info","ts":"2026-03-06T01:19:19.299292Z","caller":"traceutil/trace.go:171","msg":"trace[708395694] transaction","detail":"{read_only:false; response_revision:22667; number_of_response:1; }","duration":"328.401474ms","start":"2026-03-06T01:19:18.970845Z","end":"2026-03-06T01:19:19.299247Z","steps":["trace[708395694] 'process raft request' (duration: 289.571054ms)","trace[708395694] 'compare' (duration: 38.593734ms)"],"step_count":2} {"level":"info","ts":"2026-03-06T01:19:19.299627Z","caller":"traceutil/trace.go:171","msg":"trace[1227570668] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:22668; }","duration":"366.601547ms","start":"2026-03-06T01:19:18.933007Z","end":"2026-03-06T01:19:19.299609Z","steps":["trace[1227570668] 'agreement among raft nodes before linearized reading' (duration: 366.35779ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T01:19:19.299657Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T01:19:18.932975Z","time spent":"366.676719ms","remote":"127.0.0.1:47056","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":581,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"warn","ts":"2026-03-06T01:19:19.299664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"367.876421ms","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-03-06T01:19:19.299665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"367.912012ms","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-03-06T01:19:19.299711Z","caller":"traceutil/trace.go:171","msg":"trace[1678037133] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:22668; }","duration":"367.958663ms","start":"2026-03-06T01:19:18.931738Z","end":"2026-03-06T01:19:19.299697Z","steps":["trace[1678037133] 'agreement among raft nodes before linearized reading' (duration: 367.674086ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T01:19:19.29972Z","caller":"traceutil/trace.go:171","msg":"trace[1844923767] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:22668; }","duration":"368.004724ms","start":"2026-03-06T01:19:18.9317Z","end":"2026-03-06T01:19:19.299705Z","steps":["trace[1844923767] 'agreement among raft nodes before linearized reading' (duration: 367.816239ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T01:19:19.29976Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T01:19:18.931693Z","time spent":"368.057575ms","remote":"127.0.0.1:47056","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":505,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-03-06T01:19:19.29976Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T01:19:18.931733Z","time spent":"368.017414ms","remote":"127.0.0.1:47056","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":464,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-03-06T01:19:19.299772Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T01:19:18.970827Z","time spent":"328.830666ms","remote":"127.0.0.1:56038","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7516,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-06T01:19:19.299779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.808247ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-03-06T01:19:19.299882Z","caller":"traceutil/trace.go:171","msg":"trace[1683362310] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:22668; }","duration":"206.971103ms","start":"2026-03-06T01:19:19.092884Z","end":"2026-03-06T01:19:19.299855Z","steps":["trace[1683362310] 'agreement among raft nodes before linearized reading' (duration: 206.777507ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T01:19:19.559725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.520129ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-03-06T01:19:19.560021Z","caller":"traceutil/trace.go:171","msg":"trace[1731292263] linearizableReadLoop","detail":"{readStateIndex:23446; appliedIndex:23445; }","duration":"260.612649ms","start":"2026-03-06T01:19:19.299382Z","end":"2026-03-06T01:19:19.559995Z","steps":["trace[1731292263] 'read index received' (duration: 760.471µs)","trace[1731292263] 'applied index is now lower than readState.Index' (duration: 259.849808ms)"],"step_count":2} {"level":"info","ts":"2026-03-06T01:19:19.560166Z","caller":"traceutil/trace.go:171","msg":"trace[1063475695] transaction","detail":"{read_only:false; response_revision:22669; number_of_response:1; }","duration":"255.648006ms","start":"2026-03-06T01:19:19.304493Z","end":"2026-03-06T01:19:19.560141Z","steps":["trace[1063475695] 'process raft request' (duration: 255.43528ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T01:19:19.560222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.225221ms","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:6"} {"level":"info","ts":"2026-03-06T01:19:19.560263Z","caller":"traceutil/trace.go:171","msg":"trace[1843024013] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectzones/; range_end:/registry/ceph.rook.io/cephobjectzones0; response_count:0; response_revision:22669; }","duration":"318.316243ms","start":"2026-03-06T01:19:19.241931Z","end":"2026-03-06T01:19:19.560247Z","steps":["trace[1843024013] 'agreement among raft nodes before linearized reading' (duration: 318.17666ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T01:19:19.560297Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T01:19:19.24192Z","time spent":"318.367604ms","remote":"127.0.0.1:56092","response type":"/etcdserverpb.KV/Range","request count":0,"request size":84,"response count":0,"response size":29,"request content":"key:\"/registry/ceph.rook.io/cephobjectzones/\" range_end:\"/registry/ceph.rook.io/cephobjectzones0\" count_only:true "} {"level":"warn","ts":"2026-03-06T01:19:19.56043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.696344ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-03-06T01:19:19.560487Z","caller":"traceutil/trace.go:171","msg":"trace[178934261] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:22669; }","duration":"340.823157ms","start":"2026-03-06T01:19:19.219648Z","end":"2026-03-06T01:19:19.560471Z","steps":["trace[178934261] 'agreement among raft nodes before linearized reading' (duration: 340.693844ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T01:19:19.560484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"441.016571ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"warn","ts":"2026-03-06T01:19:19.560514Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T01:19:19.21962Z","time spent":"340.887739ms","remote":"127.0.0.1:47054","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":1,"response size":31,"request content":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true "} {"level":"info","ts":"2026-03-06T01:19:19.560522Z","caller":"traceutil/trace.go:171","msg":"trace[1804062911] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:22669; }","duration":"441.110283ms","start":"2026-03-06T01:19:19.119399Z","end":"2026-03-06T01:19:19.560509Z","steps":["trace[1804062911] 'agreement among raft nodes before linearized reading' (duration: 440.960449ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T01:19:19.560555Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T01:19:19.119375Z","time spent":"441.171425ms","remote":"127.0.0.1:47056","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":517,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-03-06T01:19:19.571256Z","caller":"traceutil/trace.go:171","msg":"trace[1128558490] transaction","detail":"{read_only:false; response_revision:22671; number_of_response:1; }","duration":"266.162807ms","start":"2026-03-06T01:19:19.305061Z","end":"2026-03-06T01:19:19.571224Z","steps":["trace[1128558490] 'process raft request' (duration: 266.107626ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T01:19:19.571323Z","caller":"traceutil/trace.go:171","msg":"trace[141377699] transaction","detail":"{read_only:false; response_revision:22670; number_of_response:1; }","duration":"266.603429ms","start":"2026-03-06T01:19:19.304681Z","end":"2026-03-06T01:19:19.571285Z","steps":["trace[141377699] 'process raft request' (duration: 266.311341ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T01:19:19.583981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.766672ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-03-06T01:19:19.584079Z","caller":"traceutil/trace.go:171","msg":"trace[225760794] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:22673; }","duration":"282.889955ms","start":"2026-03-06T01:19:19.301169Z","end":"2026-03-06T01:19:19.584059Z","steps":["trace[225760794] 'agreement among raft nodes before linearized reading' (duration: 282.748402ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T01:19:19.584426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.766545ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" ","response":"range_response_count:1 size:18441"} {"level":"info","ts":"2026-03-06T01:19:19.584471Z","caller":"traceutil/trace.go:171","msg":"trace[329183890] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:1; response_revision:22673; }","duration":"278.813426ms","start":"2026-03-06T01:19:19.305647Z","end":"2026-03-06T01:19:19.58446Z","steps":["trace[329183890] 'agreement among raft nodes before linearized reading' (duration: 278.119918ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T01:19:19.905592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.707597ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-03-06T01:19:19.906042Z","caller":"traceutil/trace.go:171","msg":"trace[660319979] transaction","detail":"{read_only:false; response_revision:22674; number_of_response:1; }","duration":"204.25873ms","start":"2026-03-06T01:19:19.701739Z","end":"2026-03-06T01:19:19.905998Z","steps":["trace[660319979] 'process raft request' (duration: 38.043099ms)","trace[660319979] 'compare' (duration: 165.560693ms)"],"step_count":2} {"level":"info","ts":"2026-03-06T01:19:20.426615Z","caller":"traceutil/trace.go:171","msg":"trace[1964615509] transaction","detail":"{read_only:false; response_revision:22676; number_of_response:1; }","duration":"323.860233ms","start":"2026-03-06T01:19:20.102728Z","end":"2026-03-06T01:19:20.426588Z","steps":["trace[1964615509] 'process raft request' (duration: 323.611906ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T01:19:20.426791Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T01:19:20.1027Z","time spent":"323.995637ms","remote":"127.0.0.1:47056","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-06T01:19:20.442862Z","caller":"traceutil/trace.go:171","msg":"trace[359912675] linearizableReadLoop","detail":"{readStateIndex:23455; appliedIndex:23453; }","duration":"108.916557ms","start":"2026-03-06T01:19:20.333928Z","end":"2026-03-06T01:19:20.442844Z","steps":["trace[359912675] 'read index received' (duration: 92.423686ms)","trace[359912675] 'applied index is now lower than readState.Index' (duration: 16.491301ms)"],"step_count":2} {"level":"warn","ts":"2026-03-06T01:19:20.443008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.075451ms","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:6"} {"level":"info","ts":"2026-03-06T01:19:20.443054Z","caller":"traceutil/trace.go:171","msg":"trace[455100403] range","detail":"{range_begin:/registry/rabbitmq.com/permissions/; range_end:/registry/rabbitmq.com/permissions0; response_count:0; response_revision:22678; }","duration":"109.176144ms","start":"2026-03-06T01:19:20.333863Z","end":"2026-03-06T01:19:20.443039Z","steps":["trace[455100403] 'agreement among raft nodes before linearized reading' (duration: 109.062061ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T01:19:20.442995Z","caller":"traceutil/trace.go:171","msg":"trace[1575920841] transaction","detail":"{read_only:false; response_revision:22677; number_of_response:1; }","duration":"137.573545ms","start":"2026-03-06T01:19:20.305302Z","end":"2026-03-06T01:19:20.442876Z","steps":["trace[1575920841] 'process raft request' (duration: 137.148723ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T01:19:34.687359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.969144ms","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-03-06T01:19:34.687489Z","caller":"traceutil/trace.go:171","msg":"trace[1229581172] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:22828; }","duration":"191.169519ms","start":"2026-03-06T01:19:34.496292Z","end":"2026-03-06T01:19:34.687462Z","steps":["trace[1229581172] 'range keys from in-memory index tree' (duration: 190.764118ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T01:19:34.687685Z","caller":"traceutil/trace.go:171","msg":"trace[584054104] transaction","detail":"{read_only:false; response_revision:22829; number_of_response:1; }","duration":"159.044228ms","start":"2026-03-06T01:19:34.528511Z","end":"2026-03-06T01:19:34.687555Z","steps":["trace[584054104] 'process raft request' (duration: 156.82578ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T01:19:34.960466Z","caller":"traceutil/trace.go:171","msg":"trace[2106651265] linearizableReadLoop","detail":"{readStateIndex:23612; appliedIndex:23611; }","duration":"197.213922ms","start":"2026-03-06T01:19:34.763232Z","end":"2026-03-06T01:19:34.960446Z","steps":["trace[2106651265] 'read index received' (duration: 197.066298ms)","trace[2106651265] 'applied index is now lower than readState.Index' (duration: 146.474µs)"],"step_count":2} {"level":"warn","ts":"2026-03-06T01:19:34.960674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.423877ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-26f83e29-3ec0-4d6e-bf93-d16ac85fef90\" ","response":"range_response_count:1 size:3644"} {"level":"info","ts":"2026-03-06T01:19:34.960703Z","caller":"traceutil/trace.go:171","msg":"trace[54476786] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-26f83e29-3ec0-4d6e-bf93-d16ac85fef90; range_end:; response_count:1; response_revision:22831; }","duration":"197.51409ms","start":"2026-03-06T01:19:34.76318Z","end":"2026-03-06T01:19:34.960694Z","steps":["trace[54476786] 'agreement among raft nodes before linearized reading' (duration: 197.350266ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T01:19:34.960973Z","caller":"traceutil/trace.go:171","msg":"trace[840514800] transaction","detail":"{read_only:false; response_revision:22831; number_of_response:1; }","duration":"269.805694ms","start":"2026-03-06T01:19:34.691159Z","end":"2026-03-06T01:19:34.960964Z","steps":["trace[840514800] 'process raft request' (duration: 269.138577ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T01:19:35.426784Z","caller":"traceutil/trace.go:171","msg":"trace[1292203434] transaction","detail":"{read_only:false; response_revision:22835; number_of_response:1; }","duration":"458.000264ms","start":"2026-03-06T01:19:34.968746Z","end":"2026-03-06T01:19:35.426746Z","steps":["trace[1292203434] 'process raft request' (duration: 457.695056ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T01:19:35.427056Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T01:19:34.968735Z","time spent":"458.229361ms","remote":"127.0.0.1:47000","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3743,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-06T01:19:35.595188Z","caller":"traceutil/trace.go:171","msg":"trace[1031354352] linearizableReadLoop","detail":"{readStateIndex:23618; appliedIndex:23615; }","duration":"268.261503ms","start":"2026-03-06T01:19:35.326902Z","end":"2026-03-06T01:19:35.595164Z","steps":["trace[1031354352] 'read index received' (duration: 99.584366ms)","trace[1031354352] 'applied index is now lower than readState.Index' (duration: 168.676177ms)"],"step_count":2} {"level":"info","ts":"2026-03-06T01:19:35.59555Z","caller":"traceutil/trace.go:171","msg":"trace[1681563930] transaction","detail":"{read_only:false; response_revision:22836; number_of_response:1; }","duration":"558.552278ms","start":"2026-03-06T01:19:35.036985Z","end":"2026-03-06T01:19:35.595537Z","steps":["trace[1681563930] 'process raft request' (duration: 557.961341ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T01:19:35.595675Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T01:19:35.036967Z","time spent":"558.62418ms","remote":"127.0.0.1:47056","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-06T01:19:35.596041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.972896ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila\" ","response":"range_response_count:1 size:3236"} {"level":"info","ts":"2026-03-06T01:19:35.596111Z","caller":"traceutil/trace.go:171","msg":"trace[506887534] transaction","detail":"{read_only:false; response_revision:22837; number_of_response:1; }","duration":"394.425613ms","start":"2026-03-06T01:19:35.201676Z","end":"2026-03-06T01:19:35.596101Z","steps":["trace[506887534] 'process raft request' (duration: 393.435766ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T01:19:35.596134Z","caller":"traceutil/trace.go:171","msg":"trace[588724014] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila; range_end:; response_count:1; response_revision:22837; }","duration":"194.118079ms","start":"2026-03-06T01:19:35.401995Z","end":"2026-03-06T01:19:35.596113Z","steps":["trace[588724014] 'agreement among raft nodes before linearized reading' (duration: 193.823352ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T01:19:35.596169Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T01:19:35.201657Z","time spent":"394.478504ms","remote":"127.0.0.1:47056","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":607,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-06T01:19:35.596327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.436566ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ipam.cluster.x-k8s.io/ipaddresses/\" range_end:\"/registry/ipam.cluster.x-k8s.io/ipaddresses0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-03-06T01:19:35.596366Z","caller":"traceutil/trace.go:171","msg":"trace[1419084390] range","detail":"{range_begin:/registry/ipam.cluster.x-k8s.io/ipaddresses/; range_end:/registry/ipam.cluster.x-k8s.io/ipaddresses0; response_count:0; response_revision:22837; }","duration":"269.533658ms","start":"2026-03-06T01:19:35.326822Z","end":"2026-03-06T01:19:35.596356Z","steps":["trace[1419084390] 'agreement among raft nodes before linearized reading' (duration: 269.477516ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T01:19:35.596477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.48303ms","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-03-06T01:19:35.596522Z","caller":"traceutil/trace.go:171","msg":"trace[1534677941] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:22837; }","duration":"141.571792ms","start":"2026-03-06T01:19:35.454938Z","end":"2026-03-06T01:19:35.59651Z","steps":["trace[1534677941] 'agreement among raft nodes before linearized reading' (duration: 141.460499ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T01:19:35.59667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.550923ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-26f83e29-3ec0-4d6e-bf93-d16ac85fef90\" ","response":"range_response_count:1 size:3761"} {"level":"info","ts":"2026-03-06T01:19:35.596705Z","caller":"traceutil/trace.go:171","msg":"trace[1675282512] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-26f83e29-3ec0-4d6e-bf93-d16ac85fef90; range_end:; response_count:1; response_revision:22837; }","duration":"187.636005ms","start":"2026-03-06T01:19:35.40906Z","end":"2026-03-06T01:19:35.596696Z","steps":["trace[1675282512] 'agreement among raft nodes before linearized reading' (duration: 187.546592ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T01:19:35.596069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.738716ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-03-06T01:19:35.596886Z","caller":"traceutil/trace.go:171","msg":"trace[2021895427] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:22837; }","duration":"136.586259ms","start":"2026-03-06T01:19:35.460289Z","end":"2026-03-06T01:19:35.596875Z","steps":["trace[2021895427] 'agreement among raft nodes before linearized reading' (duration: 135.740156ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T01:19:35.760194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.088594ms","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-03-06T01:19:35.760271Z","caller":"traceutil/trace.go:171","msg":"trace[496682518] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:22839; }","duration":"105.216127ms","start":"2026-03-06T01:19:35.655036Z","end":"2026-03-06T01:19:35.760252Z","steps":["trace[496682518] 'agreement among raft nodes before linearized reading' (duration: 105.036642ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T01:19:35.760477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.639726ms","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-03-06T01:19:35.760517Z","caller":"traceutil/trace.go:171","msg":"trace[1687432478] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:22839; }","duration":"103.678417ms","start":"2026-03-06T01:19:35.656829Z","end":"2026-03-06T01:19:35.760508Z","steps":["trace[1687432478] 'agreement among raft nodes before linearized reading' (duration: 103.586054ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T01:19:35.923422Z","caller":"traceutil/trace.go:171","msg":"trace[496099536] transaction","detail":"{read_only:false; response_revision:22840; number_of_response:1; }","duration":"158.258598ms","start":"2026-03-06T01:19:35.76513Z","end":"2026-03-06T01:19:35.923389Z","steps":["trace[496099536] 'process raft request' (duration: 121.953156ms)","trace[496099536] 'compare' (duration: 36.096006ms)"],"step_count":2} {"level":"info","ts":"2026-03-06T01:19:36.014319Z","caller":"traceutil/trace.go:171","msg":"trace[539281242] transaction","detail":"{read_only:false; response_revision:22842; number_of_response:1; }","duration":"248.981818ms","start":"2026-03-06T01:19:35.765319Z","end":"2026-03-06T01:19:36.014301Z","steps":["trace[539281242] 'process raft request' (duration: 248.806293ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T01:19:36.014386Z","caller":"traceutil/trace.go:171","msg":"trace[302567704] transaction","detail":"{read_only:false; response_revision:22843; number_of_response:1; }","duration":"249.037149ms","start":"2026-03-06T01:19:35.765338Z","end":"2026-03-06T01:19:36.014375Z","steps":["trace[302567704] 'process raft request' (duration: 248.831134ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T01:19:36.014303Z","caller":"traceutil/trace.go:171","msg":"trace[1045355650] transaction","detail":"{read_only:false; response_revision:22841; number_of_response:1; }","duration":"249.086851ms","start":"2026-03-06T01:19:35.765186Z","end":"2026-03-06T01:19:36.014273Z","steps":["trace[1045355650] 'process raft request' (duration: 248.858165ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T01:19:36.01454Z","caller":"traceutil/trace.go:171","msg":"trace[1114074107] transaction","detail":"{read_only:false; response_revision:22844; number_of_response:1; }","duration":"245.623368ms","start":"2026-03-06T01:19:35.768906Z","end":"2026-03-06T01:19:36.014529Z","steps":["trace[1114074107] 'process raft request' (duration: 245.3337ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T01:19:36.014713Z","caller":"traceutil/trace.go:171","msg":"trace[1468624478] linearizableReadLoop","detail":"{readStateIndex:23624; appliedIndex:23620; }","duration":"247.933578ms","start":"2026-03-06T01:19:35.766739Z","end":"2026-03-06T01:19:36.014673Z","steps":["trace[1468624478] 'read index received' (duration: 120.361843ms)","trace[1468624478] 'applied index is now lower than readState.Index' (duration: 127.570125ms)"],"step_count":2} {"level":"info","ts":"2026-03-06T01:19:36.014774Z","caller":"traceutil/trace.go:171","msg":"trace[771419305] transaction","detail":"{read_only:false; response_revision:22845; number_of_response:1; }","duration":"245.68297ms","start":"2026-03-06T01:19:35.769072Z","end":"2026-03-06T01:19:36.014755Z","steps":["trace[771419305] 'process raft request' (duration: 245.425133ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T01:19:36.015004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.254647ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/rabbitmq-manila\" ","response":"range_response_count:1 size:1444"} {"level":"info","ts":"2026-03-06T01:19:36.015062Z","caller":"traceutil/trace.go:171","msg":"trace[269629805] range","detail":"{range_begin:/registry/services/specs/openstack/rabbitmq-manila; range_end:; response_count:1; response_revision:22845; }","duration":"248.347049ms","start":"2026-03-06T01:19:35.7667Z","end":"2026-03-06T01:19:36.015047Z","steps":["trace[269629805] 'agreement among raft nodes before linearized reading' (duration: 248.093253ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T01:19:36.179831Z","caller":"traceutil/trace.go:171","msg":"trace[566676722] linearizableReadLoop","detail":"{readStateIndex:23627; appliedIndex:23626; }","duration":"138.615942ms","start":"2026-03-06T01:19:36.041199Z","end":"2026-03-06T01:19:36.179815Z","steps":["trace[566676722] 'read index received' (duration: 138.465628ms)","trace[566676722] 'applied index is now lower than readState.Index' (duration: 149.314µs)"],"step_count":2} {"level":"info","ts":"2026-03-06T01:19:36.179926Z","caller":"traceutil/trace.go:171","msg":"trace[210748394] transaction","detail":"{read_only:false; response_revision:22846; number_of_response:1; }","duration":"141.015576ms","start":"2026-03-06T01:19:36.0389Z","end":"2026-03-06T01:19:36.179916Z","steps":["trace[210748394] 'process raft request' (duration: 140.79713ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T01:19:36.180374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.160806ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-manila-server-0\" ","response":"range_response_count:1 size:1446"} {"level":"info","ts":"2026-03-06T01:19:36.180445Z","caller":"traceutil/trace.go:171","msg":"trace[31890514] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-manila-server-0; range_end:; response_count:1; response_revision:22846; }","duration":"139.259938ms","start":"2026-03-06T01:19:36.041168Z","end":"2026-03-06T01:19:36.180428Z","steps":["trace[31890514] 'agreement among raft nodes before linearized reading' (duration: 139.095974ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T01:19:36.39024Z","caller":"traceutil/trace.go:171","msg":"trace[1116316033] transaction","detail":"{read_only:false; response_revision:22847; number_of_response:1; }","duration":"194.052917ms","start":"2026-03-06T01:19:36.196158Z","end":"2026-03-06T01:19:36.390211Z","steps":["trace[1116316033] 'process raft request' (duration: 193.847401ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T01:19:36.991487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"390.017614ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-26f83e29-3ec0-4d6e-bf93-d16ac85fef90\" ","response":"range_response_count:1 size:3761"} {"level":"info","ts":"2026-03-06T01:19:36.991585Z","caller":"traceutil/trace.go:171","msg":"trace[334633413] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-26f83e29-3ec0-4d6e-bf93-d16ac85fef90; range_end:; response_count:1; response_revision:22847; }","duration":"390.181259ms","start":"2026-03-06T01:19:36.601379Z","end":"2026-03-06T01:19:36.99156Z","steps":["trace[334633413] 'range keys from in-memory index tree' (duration: 389.768638ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T01:19:36.991633Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T01:19:36.601341Z","time spent":"390.279112ms","remote":"127.0.0.1:47000","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3784,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-26f83e29-3ec0-4d6e-bf93-d16ac85fef90\" "} {"level":"info","ts":"2026-03-06T01:19:37.007162Z","caller":"traceutil/trace.go:171","msg":"trace[536059389] transaction","detail":"{read_only:false; response_revision:22848; number_of_response:1; }","duration":"312.632952ms","start":"2026-03-06T01:19:36.694507Z","end":"2026-03-06T01:19:37.00714Z","steps":["trace[536059389] 'process raft request' (duration: 312.487818ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T01:19:37.007451Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T01:19:36.694474Z","time spent":"312.872349ms","remote":"127.0.0.1:47056","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-06T01:19:37.281563Z","caller":"traceutil/trace.go:171","msg":"trace[1511584815] linearizableReadLoop","detail":"{readStateIndex:23630; appliedIndex:23628; }","duration":"396.035215ms","start":"2026-03-06T01:19:36.885467Z","end":"2026-03-06T01:19:37.281502Z","steps":["trace[1511584815] 'read index received' (duration: 121.470882ms)","trace[1511584815] 'applied index is now lower than readState.Index' (duration: 274.563063ms)"],"step_count":2} {"level":"info","ts":"2026-03-06T01:19:37.281891Z","caller":"traceutil/trace.go:171","msg":"trace[1500566685] transaction","detail":"{read_only:false; response_revision:22850; number_of_response:1; }","duration":"275.925549ms","start":"2026-03-06T01:19:37.005916Z","end":"2026-03-06T01:19:37.281842Z","steps":["trace[1500566685] 'process raft request' (duration: 275.503497ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T01:19:37.28193Z","caller":"traceutil/trace.go:171","msg":"trace[2073790515] transaction","detail":"{read_only:false; response_revision:22849; number_of_response:1; }","duration":"583.31557ms","start":"2026-03-06T01:19:36.698551Z","end":"2026-03-06T01:19:37.281867Z","steps":["trace[2073790515] 'process raft request' (duration: 571.081153ms)","trace[2073790515] 'compare' (duration: 11.619861ms)"],"step_count":2} {"level":"warn","ts":"2026-03-06T01:19:37.282131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"396.643692ms","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":"warn","ts":"2026-03-06T01:19:37.28222Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T01:19:36.698527Z","time spent":"583.515427ms","remote":"127.0.0.1:47056","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":498,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-06T01:19:37.282239Z","caller":"traceutil/trace.go:171","msg":"trace[1215277909] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:22850; }","duration":"396.808626ms","start":"2026-03-06T01:19:36.885411Z","end":"2026-03-06T01:19:37.282219Z","steps":["trace[1215277909] 'agreement among raft nodes before linearized reading' (duration: 396.478278ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T01:19:37.282304Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T01:19:36.885386Z","time spent":"396.899469ms","remote":"127.0.0.1:46940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":141,"response size":32,"request content":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true "} {"level":"warn","ts":"2026-03-06T01:19:37.28385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.225196ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-03-06T01:19:37.283933Z","caller":"traceutil/trace.go:171","msg":"trace[1573482683] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:22851; }","duration":"354.383919ms","start":"2026-03-06T01:19:36.929528Z","end":"2026-03-06T01:19:37.283912Z","steps":["trace[1573482683] 'agreement among raft nodes before linearized reading' (duration: 354.126912ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T01:19:37.283985Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T01:19:36.929498Z","time spent":"354.476612ms","remote":"127.0.0.1:46994","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":90,"response size":31,"request content":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true "} {"level":"info","ts":"2026-03-06T01:19:37.284164Z","caller":"traceutil/trace.go:171","msg":"trace[1923436889] transaction","detail":"{read_only:false; response_revision:22851; number_of_response:1; }","duration":"277.190022ms","start":"2026-03-06T01:19:37.006951Z","end":"2026-03-06T01:19:37.284141Z","steps":["trace[1923436889] 'process raft request' (duration: 276.525085ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T01:19:37.28448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.443876ms","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-03-06T01:19:37.284578Z","caller":"traceutil/trace.go:171","msg":"trace[802594743] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:22851; }","duration":"318.610171ms","start":"2026-03-06T01:19:36.965942Z","end":"2026-03-06T01:19:37.284552Z","steps":["trace[802594743] 'agreement among raft nodes before linearized reading' (duration: 318.285863ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T01:19:37.284625Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T01:19:36.965913Z","time spent":"318.702694ms","remote":"127.0.0.1:47056","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-03-06T01:19:39.46542Z","caller":"traceutil/trace.go:171","msg":"trace[1742321778] transaction","detail":"{read_only:false; response_revision:22864; number_of_response:1; }","duration":"177.445401ms","start":"2026-03-06T01:19:39.287943Z","end":"2026-03-06T01:19:39.465389Z","steps":["trace[1742321778] 'process raft request' (duration: 177.234856ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T01:19:39.483298Z","caller":"traceutil/trace.go:171","msg":"trace[1406137370] transaction","detail":"{read_only:false; response_revision:22866; number_of_response:1; }","duration":"192.391432ms","start":"2026-03-06T01:19:39.290873Z","end":"2026-03-06T01:19:39.483265Z","steps":["trace[1406137370] 'process raft request' (duration: 192.289979ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T01:19:39.483315Z","caller":"traceutil/trace.go:171","msg":"trace[162534017] transaction","detail":"{read_only:false; response_revision:22865; number_of_response:1; }","duration":"192.818233ms","start":"2026-03-06T01:19:39.290457Z","end":"2026-03-06T01:19:39.483275Z","steps":["trace[162534017] 'process raft request' (duration: 192.497525ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T01:19:39.487895Z","caller":"traceutil/trace.go:171","msg":"trace[1523469896] linearizableReadLoop","detail":"{readStateIndex:23648; appliedIndex:23644; }","duration":"116.404548ms","start":"2026-03-06T01:19:39.37147Z","end":"2026-03-06T01:19:39.487875Z","steps":["trace[1523469896] 'read index received' (duration: 93.765261ms)","trace[1523469896] 'applied index is now lower than readState.Index' (duration: 22.637877ms)"],"step_count":2} {"level":"warn","ts":"2026-03-06T01:19:39.48808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.613833ms","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-03-06T01:19:39.488111Z","caller":"traceutil/trace.go:171","msg":"trace[1863020234] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:22866; }","duration":"116.737757ms","start":"2026-03-06T01:19:39.371363Z","end":"2026-03-06T01:19:39.488101Z","steps":["trace[1863020234] 'agreement among raft nodes before linearized reading' (duration: 116.588113ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T01:19:43.051497Z","caller":"traceutil/trace.go:171","msg":"trace[710127592] transaction","detail":"{read_only:false; response_revision:22906; number_of_response:1; }","duration":"117.25943ms","start":"2026-03-06T01:19:42.934212Z","end":"2026-03-06T01:19:43.051472Z","steps":["trace[710127592] 'process raft request' (duration: 117.013914ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T01:19:43.312321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.050046ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-03-06T01:19:43.312444Z","caller":"traceutil/trace.go:171","msg":"trace[807115492] transaction","detail":"{read_only:false; response_revision:22907; number_of_response:1; }","duration":"255.007599ms","start":"2026-03-06T01:19:43.057413Z","end":"2026-03-06T01:19:43.31242Z","steps":["trace[807115492] 'process raft request' (duration: 113.755417ms)","trace[807115492] 'compare' (duration: 140.779009ms)"],"step_count":2} {"level":"info","ts":"2026-03-06T01:19:43.364607Z","caller":"traceutil/trace.go:171","msg":"trace[1939219100] transaction","detail":"{read_only:false; response_revision:22908; number_of_response:1; }","duration":"306.247042ms","start":"2026-03-06T01:19:43.058328Z","end":"2026-03-06T01:19:43.364575Z","steps":["trace[1939219100] 'process raft request' (duration: 305.991435ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T01:19:43.36478Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T01:19:43.058301Z","time spent":"306.384526ms","remote":"127.0.0.1:46994","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-06T01:19:43.364846Z","caller":"traceutil/trace.go:171","msg":"trace[2063001104] transaction","detail":"{read_only:false; response_revision:22909; number_of_response:1; }","duration":"306.332643ms","start":"2026-03-06T01:19:43.058488Z","end":"2026-03-06T01:19:43.364821Z","steps":["trace[2063001104] 'process raft request' (duration: 306.011345ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T01:19:43.365001Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T01:19:43.058461Z","time spent":"306.458396ms","remote":"127.0.0.1:47066","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1415,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-06T01:19:43.365143Z","caller":"traceutil/trace.go:171","msg":"trace[698609064] transaction","detail":"{read_only:false; response_revision:22910; number_of_response:1; }","duration":"306.153939ms","start":"2026-03-06T01:19:43.058977Z","end":"2026-03-06T01:19:43.365131Z","steps":["trace[698609064] 'process raft request' (duration: 305.748028ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T01:19:43.365203Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T01:19:43.058961Z","time spent":"306.21178ms","remote":"127.0.0.1:47066","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1490,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-06T01:19:43.365211Z","caller":"traceutil/trace.go:171","msg":"trace[1567290831] linearizableReadLoop","detail":"{readStateIndex:23693; appliedIndex:23689; }","duration":"305.738247ms","start":"2026-03-06T01:19:43.059454Z","end":"2026-03-06T01:19:43.365193Z","steps":["trace[1567290831] 'read index received' (duration: 111.748293ms)","trace[1567290831] 'applied index is now lower than readState.Index' (duration: 193.988644ms)"],"step_count":2} {"level":"info","ts":"2026-03-06T01:19:43.365241Z","caller":"traceutil/trace.go:171","msg":"trace[1651288145] transaction","detail":"{read_only:false; response_revision:22912; number_of_response:1; }","duration":"263.27787ms","start":"2026-03-06T01:19:43.101939Z","end":"2026-03-06T01:19:43.365217Z","steps":["trace[1651288145] 'process raft request' (duration: 263.186467ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T01:19:43.365301Z","caller":"traceutil/trace.go:171","msg":"trace[1285313301] transaction","detail":"{read_only:false; response_revision:22911; number_of_response:1; }","duration":"305.218974ms","start":"2026-03-06T01:19:43.060073Z","end":"2026-03-06T01:19:43.365292Z","steps":["trace[1285313301] 'process raft request' (duration: 304.958127ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T01:19:43.365358Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T01:19:43.060061Z","time spent":"305.270145ms","remote":"127.0.0.1:46994","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":885,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-06T01:19:43.365476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.014194ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"} {"level":"warn","ts":"2026-03-06T01:19:43.365449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.130884ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-03-06T01:19:43.365519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.527036ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/clusterclasses/\" range_end:\"/registry/cluster.x-k8s.io/clusterclasses0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-03-06T01:19:43.365525Z","caller":"traceutil/trace.go:171","msg":"trace[191404588] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:22912; }","duration":"306.104247ms","start":"2026-03-06T01:19:43.05941Z","end":"2026-03-06T01:19:43.365514Z","steps":["trace[191404588] 'agreement among raft nodes before linearized reading' (duration: 305.895551ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T01:19:43.365555Z","caller":"traceutil/trace.go:171","msg":"trace[700617404] range","detail":"{range_begin:/registry/cluster.x-k8s.io/clusterclasses/; range_end:/registry/cluster.x-k8s.io/clusterclasses0; response_count:0; response_revision:22912; }","duration":"201.596748ms","start":"2026-03-06T01:19:43.163947Z","end":"2026-03-06T01:19:43.365544Z","steps":["trace[700617404] 'agreement among raft nodes before linearized reading' (duration: 201.517866ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T01:19:43.365551Z","caller":"traceutil/trace.go:171","msg":"trace[2090532479] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:22912; }","duration":"273.278517ms","start":"2026-03-06T01:19:43.092248Z","end":"2026-03-06T01:19:43.365527Z","steps":["trace[2090532479] 'agreement among raft nodes before linearized reading' (duration: 273.097092ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T01:19:43.365563Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T01:19:43.059397Z","time spent":"306.157158ms","remote":"127.0.0.1:47000","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12236,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-03-06T01:20:03.71796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.015517ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-03-06T01:20:03.718102Z","caller":"traceutil/trace.go:171","msg":"trace[1991321616] transaction","detail":"{read_only:false; response_revision:23084; number_of_response:1; }","duration":"149.915914ms","start":"2026-03-06T01:20:03.56816Z","end":"2026-03-06T01:20:03.718076Z","steps":["trace[1991321616] 'process raft request' (duration: 36.560409ms)","trace[1991321616] 'compare' (duration: 112.734438ms)"],"step_count":2} {"level":"info","ts":"2026-03-06T01:20:03.72792Z","caller":"traceutil/trace.go:171","msg":"trace[1449915633] transaction","detail":"{read_only:false; response_revision:23086; number_of_response:1; }","duration":"140.015019ms","start":"2026-03-06T01:20:03.587881Z","end":"2026-03-06T01:20:03.727896Z","steps":["trace[1449915633] 'process raft request' (duration: 139.972148ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T01:20:03.728169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.982787ms","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-03-06T01:20:03.728214Z","caller":"traceutil/trace.go:171","msg":"trace[1795793657] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:23086; }","duration":"122.076509ms","start":"2026-03-06T01:20:03.606128Z","end":"2026-03-06T01:20:03.728205Z","steps":["trace[1795793657] 'agreement among raft nodes before linearized reading' (duration: 121.889625ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T01:20:03.72843Z","caller":"traceutil/trace.go:171","msg":"trace[477714133] transaction","detail":"{read_only:false; response_revision:23085; number_of_response:1; }","duration":"149.093092ms","start":"2026-03-06T01:20:03.579327Z","end":"2026-03-06T01:20:03.728421Z","steps":["trace[477714133] 'process raft request' (duration: 148.391494ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T01:20:03.727987Z","caller":"traceutil/trace.go:171","msg":"trace[1515050574] linearizableReadLoop","detail":"{readStateIndex:23874; appliedIndex:23874; }","duration":"121.804522ms","start":"2026-03-06T01:20:03.606167Z","end":"2026-03-06T01:20:03.727971Z","steps":["trace[1515050574] 'read index received' (duration: 121.796812ms)","trace[1515050574] 'applied index is now lower than readState.Index' (duration: 6.96µs)"],"step_count":2} {"level":"info","ts":"2026-03-06T01:20:03.911984Z","caller":"traceutil/trace.go:171","msg":"trace[1123248234] linearizableReadLoop","detail":"{readStateIndex:23875; appliedIndex:23874; }","duration":"183.398802ms","start":"2026-03-06T01:20:03.728544Z","end":"2026-03-06T01:20:03.911943Z","steps":["trace[1123248234] 'read index received' (duration: 139.489746ms)","trace[1123248234] 'applied index is now lower than readState.Index' (duration: 43.907966ms)"],"step_count":2} {"level":"info","ts":"2026-03-06T01:20:03.912221Z","caller":"traceutil/trace.go:171","msg":"trace[1356979806] transaction","detail":"{read_only:false; response_revision:23087; number_of_response:1; }","duration":"206.377076ms","start":"2026-03-06T01:20:03.705771Z","end":"2026-03-06T01:20:03.912148Z","steps":["trace[1356979806] 'process raft request' (duration: 162.225154ms)","trace[1356979806] 'compare' (duration: 43.71442ms)"],"step_count":2} {"level":"info","ts":"2026-03-06T01:20:03.912262Z","caller":"traceutil/trace.go:171","msg":"trace[1604478333] transaction","detail":"{read_only:false; response_revision:23088; number_of_response:1; }","duration":"177.648098ms","start":"2026-03-06T01:20:03.734582Z","end":"2026-03-06T01:20:03.91223Z","steps":["trace[1604478333] 'process raft request' (duration: 177.320989ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T01:20:03.912371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.062684ms","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-03-06T01:20:03.912421Z","caller":"traceutil/trace.go:171","msg":"trace[542848791] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-pdbstatemap; range_end:; response_count:1; response_revision:23088; }","duration":"201.180977ms","start":"2026-03-06T01:20:03.711225Z","end":"2026-03-06T01:20:03.912406Z","steps":["trace[542848791] 'agreement among raft nodes before linearized reading' (duration: 200.91483ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T01:20:03.912736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.423988ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"} {"level":"info","ts":"2026-03-06T01:20:03.912771Z","caller":"traceutil/trace.go:171","msg":"trace[1855185887] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:23089; }","duration":"175.510491ms","start":"2026-03-06T01:20:03.737252Z","end":"2026-03-06T01:20:03.912763Z","steps":["trace[1855185887] 'agreement among raft nodes before linearized reading' (duration: 175.357477ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T01:20:03.912952Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.449626ms","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-03-06T01:20:03.912999Z","caller":"traceutil/trace.go:171","msg":"trace[985860100] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:23089; }","duration":"101.537289ms","start":"2026-03-06T01:20:03.811448Z","end":"2026-03-06T01:20:03.912985Z","steps":["trace[985860100] 'agreement among raft nodes before linearized reading' (duration: 101.434626ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T01:20:04.252785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.273825ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-03-06T01:20:04.252944Z","caller":"traceutil/trace.go:171","msg":"trace[941534972] linearizableReadLoop","detail":"{readStateIndex:23878; appliedIndex:23877; }","duration":"332.438302ms","start":"2026-03-06T01:20:03.92049Z","end":"2026-03-06T01:20:04.252928Z","steps":["trace[941534972] 'read index received' (duration: 135.981631ms)","trace[941534972] 'applied index is now lower than readState.Index' (duration: 196.454801ms)"],"step_count":2} {"level":"info","ts":"2026-03-06T01:20:04.25302Z","caller":"traceutil/trace.go:171","msg":"trace[829200829] transaction","detail":"{read_only:false; response_revision:23090; number_of_response:1; }","duration":"335.008791ms","start":"2026-03-06T01:20:03.917966Z","end":"2026-03-06T01:20:04.252974Z","steps":["trace[829200829] 'process raft request' (duration: 138.456878ms)","trace[829200829] 'compare' (duration: 195.495295ms)"],"step_count":2} {"level":"warn","ts":"2026-03-06T01:20:04.253257Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T01:20:03.917942Z","time spent":"335.175065ms","remote":"127.0.0.1:47056","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-06T01:20:04.25349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.995396ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"} {"level":"info","ts":"2026-03-06T01:20:04.253551Z","caller":"traceutil/trace.go:171","msg":"trace[797391734] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:23090; }","duration":"333.093109ms","start":"2026-03-06T01:20:03.920448Z","end":"2026-03-06T01:20:04.253541Z","steps":["trace[797391734] 'agreement among raft nodes before linearized reading' (duration: 332.613516ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T01:20:04.253598Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T01:20:03.920429Z","time spent":"333.160151ms","remote":"127.0.0.1:47000","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12236,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-03-06T01:20:04.25372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.656814ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/openstack/rabbitmq-manila-default-user\" ","response":"range_response_count:1 size:1155"} {"level":"info","ts":"2026-03-06T01:20:04.253824Z","caller":"traceutil/trace.go:171","msg":"trace[2093501221] range","detail":"{range_begin:/registry/secrets/openstack/rabbitmq-manila-default-user; range_end:; response_count:1; response_revision:23090; }","duration":"107.806487ms","start":"2026-03-06T01:20:04.145987Z","end":"2026-03-06T01:20:04.253794Z","steps":["trace[2093501221] 'agreement among raft nodes before linearized reading' (duration: 107.621493ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T01:20:04.253722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.178445ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.169\" ","response":"range_response_count:1 size:140"} {"level":"info","ts":"2026-03-06T01:20:04.253928Z","caller":"traceutil/trace.go:171","msg":"trace[171407950] range","detail":"{range_begin:/registry/masterleases/199.204.45.169; range_end:; response_count:1; response_revision:23090; }","duration":"292.427321ms","start":"2026-03-06T01:20:03.961481Z","end":"2026-03-06T01:20:04.253908Z","steps":["trace[171407950] 'agreement among raft nodes before linearized reading' (duration: 292.02145ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T01:20:04.253961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.742327ms","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-03-06T01:20:04.254088Z","caller":"traceutil/trace.go:171","msg":"trace[477610277] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:23090; }","duration":"181.932062ms","start":"2026-03-06T01:20:04.072122Z","end":"2026-03-06T01:20:04.254055Z","steps":["trace[477610277] 'agreement among raft nodes before linearized reading' (duration: 181.532862ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T01:20:04.394885Z","caller":"traceutil/trace.go:171","msg":"trace[488240343] transaction","detail":"{read_only:false; response_revision:23093; number_of_response:1; }","duration":"136.090855ms","start":"2026-03-06T01:20:04.258769Z","end":"2026-03-06T01:20:04.39486Z","steps":["trace[488240343] 'process raft request' (duration: 136.031163ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T01:20:04.394954Z","caller":"traceutil/trace.go:171","msg":"trace[1465399922] transaction","detail":"{read_only:false; response_revision:23092; number_of_response:1; }","duration":"136.447935ms","start":"2026-03-06T01:20:04.258483Z","end":"2026-03-06T01:20:04.39493Z","steps":["trace[1465399922] 'process raft request' (duration: 136.277ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T01:20:04.394976Z","caller":"traceutil/trace.go:171","msg":"trace[41784440] transaction","detail":"{read_only:false; response_revision:23091; number_of_response:1; }","duration":"137.243525ms","start":"2026-03-06T01:20:04.257692Z","end":"2026-03-06T01:20:04.394936Z","steps":["trace[41784440] 'process raft request' (duration: 136.916136ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T01:20:04.395054Z","caller":"traceutil/trace.go:171","msg":"trace[564698168] transaction","detail":"{read_only:false; response_revision:23094; number_of_response:1; }","duration":"134.188893ms","start":"2026-03-06T01:20:04.26083Z","end":"2026-03-06T01:20:04.395019Z","steps":["trace[564698168] 'process raft request' (duration: 133.998488ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T01:20:04.39535Z","caller":"traceutil/trace.go:171","msg":"trace[144310240] transaction","detail":"{read_only:false; response_revision:23095; number_of_response:1; }","duration":"127.105314ms","start":"2026-03-06T01:20:04.268176Z","end":"2026-03-06T01:20:04.395281Z","steps":["trace[144310240] 'process raft request' (duration: 127.032962ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T01:20:05.165601Z","caller":"traceutil/trace.go:171","msg":"trace[2085750161] transaction","detail":"{read_only:false; response_revision:23096; number_of_response:1; }","duration":"129.458167ms","start":"2026-03-06T01:20:05.036114Z","end":"2026-03-06T01:20:05.165572Z","steps":["trace[2085750161] 'process raft request' (duration: 129.091047ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T01:20:05.713847Z","caller":"traceutil/trace.go:171","msg":"trace[925127234] transaction","detail":"{read_only:false; response_revision:23097; number_of_response:1; }","duration":"256.736745ms","start":"2026-03-06T01:20:05.457038Z","end":"2026-03-06T01:20:05.713775Z","steps":["trace[925127234] 'process raft request' (duration: 256.355645ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T01:20:06.158897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"411.195902ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-03-06T01:20:06.159051Z","caller":"traceutil/trace.go:171","msg":"trace[863370030] transaction","detail":"{read_only:false; response_revision:23098; number_of_response:1; }","duration":"434.226098ms","start":"2026-03-06T01:20:05.724799Z","end":"2026-03-06T01:20:06.159025Z","steps":["trace[863370030] 'process raft request' (duration: 22.761589ms)","trace[863370030] 'compare' (duration: 410.740289ms)"],"step_count":2} {"level":"warn","ts":"2026-03-06T01:20:06.159127Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T01:20:05.72478Z","time spent":"434.314291ms","remote":"127.0.0.1:47056","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":498,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-06T01:20:06.586667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.335249ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-03-06T01:20:06.587104Z","caller":"traceutil/trace.go:171","msg":"trace[190624081] transaction","detail":"{read_only:false; response_revision:23100; number_of_response:1; }","duration":"850.929086ms","start":"2026-03-06T01:20:05.73615Z","end":"2026-03-06T01:20:06.587079Z","steps":["trace[190624081] 'process raft request' (duration: 850.827213ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T01:20:06.58722Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T01:20:05.73612Z","time spent":"851.035819ms","remote":"127.0.0.1:47056","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-06T01:20:06.587643Z","caller":"traceutil/trace.go:171","msg":"trace[1339592688] transaction","detail":"{read_only:false; response_revision:23099; number_of_response:1; }","duration":"851.540693ms","start":"2026-03-06T01:20:05.736047Z","end":"2026-03-06T01:20:06.587587Z","steps":["trace[1339592688] 'process raft request' (duration: 667.151415ms)","trace[1339592688] 'compare' (duration: 183.163415ms)"],"step_count":2} {"level":"warn","ts":"2026-03-06T01:20:06.587823Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T01:20:05.736015Z","time spent":"851.702388ms","remote":"127.0.0.1:47056","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-06T01:20:06.639802Z","caller":"traceutil/trace.go:171","msg":"trace[45640609] transaction","detail":"{read_only:false; response_revision:23101; number_of_response:1; }","duration":"751.035692ms","start":"2026-03-06T01:20:05.888737Z","end":"2026-03-06T01:20:06.639773Z","steps":["trace[45640609] 'process raft request' (duration: 750.848907ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T01:20:06.640081Z","caller":"traceutil/trace.go:171","msg":"trace[1412304916] transaction","detail":"{read_only:false; response_revision:23102; number_of_response:1; }","duration":"720.984517ms","start":"2026-03-06T01:20:05.919076Z","end":"2026-03-06T01:20:06.64006Z","steps":["trace[1412304916] 'process raft request' (duration: 720.651158ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T01:20:06.64012Z","caller":"traceutil/trace.go:171","msg":"trace[1153061358] linearizableReadLoop","detail":"{readStateIndex:23890; appliedIndex:23887; }","duration":"721.161292ms","start":"2026-03-06T01:20:05.918932Z","end":"2026-03-06T01:20:06.640093Z","steps":["trace[1153061358] 'read index received' (duration: 484.33872ms)","trace[1153061358] 'applied index is now lower than readState.Index' (duration: 236.821532ms)"],"step_count":2} {"level":"warn","ts":"2026-03-06T01:20:06.640147Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T01:20:05.919059Z","time spent":"721.058119ms","remote":"127.0.0.1:47056","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-06T01:20:06.640182Z","caller":"traceutil/trace.go:171","msg":"trace[102130180] transaction","detail":"{read_only:false; response_revision:23103; number_of_response:1; }","duration":"719.876227ms","start":"2026-03-06T01:20:05.920247Z","end":"2026-03-06T01:20:06.640123Z","steps":["trace[102130180] 'process raft request' (duration: 719.720833ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T01:20:06.640326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"721.375277ms","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-03-06T01:20:06.640364Z","caller":"traceutil/trace.go:171","msg":"trace[1077899081] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:23103; }","duration":"721.49038ms","start":"2026-03-06T01:20:05.918861Z","end":"2026-03-06T01:20:06.640351Z","steps":["trace[1077899081] 'agreement among raft nodes before linearized reading' (duration: 721.344587ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T01:20:06.640398Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T01:20:05.918828Z","time spent":"721.563204ms","remote":"127.0.0.1:47056","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-03-06T01:20:06.640428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"611.443785ms","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":"warn","ts":"2026-03-06T01:20:06.640437Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T01:20:05.920234Z","time spent":"720.049092ms","remote":"127.0.0.1:47056","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":608,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-06T01:20:06.640474Z","caller":"traceutil/trace.go:171","msg":"trace[1558146462] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:23103; }","duration":"611.535567ms","start":"2026-03-06T01:20:06.028925Z","end":"2026-03-06T01:20:06.640461Z","steps":["trace[1558146462] 'agreement among raft nodes before linearized reading' (duration: 611.396553ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T01:20:06.640511Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T01:20:06.028899Z","time spent":"611.60455ms","remote":"127.0.0.1:47056","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":584,"request content":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" "} {"level":"warn","ts":"2026-03-06T01:20:06.640551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.212903ms","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-03-06T01:20:06.640576Z","caller":"traceutil/trace.go:171","msg":"trace[1905501059] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:23103; }","duration":"240.284265ms","start":"2026-03-06T01:20:06.400286Z","end":"2026-03-06T01:20:06.64057Z","steps":["trace[1905501059] 'agreement among raft nodes before linearized reading' (duration: 240.213453ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T01:20:06.640645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"381.102036ms","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-03-06T01:20:06.640677Z","caller":"traceutil/trace.go:171","msg":"trace[1409323038] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:23103; }","duration":"381.167207ms","start":"2026-03-06T01:20:06.259502Z","end":"2026-03-06T01:20:06.640669Z","steps":["trace[1409323038] 'agreement among raft nodes before linearized reading' (duration: 381.086095ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T01:20:06.640705Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T01:20:06.259479Z","time spent":"381.219209ms","remote":"127.0.0.1:47056","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-03-06T01:20:06.640823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.445219ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:557"} {"level":"warn","ts":"2026-03-06T01:20:06.64082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.419709ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-03-06T01:20:06.640854Z","caller":"traceutil/trace.go:171","msg":"trace[110826651] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:23103; }","duration":"240.482091ms","start":"2026-03-06T01:20:06.400361Z","end":"2026-03-06T01:20:06.640843Z","steps":["trace[110826651] 'agreement among raft nodes before linearized reading' (duration: 240.403118ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T01:20:06.640881Z","caller":"traceutil/trace.go:171","msg":"trace[1526919130] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:23103; }","duration":"240.46744ms","start":"2026-03-06T01:20:06.400384Z","end":"2026-03-06T01:20:06.640851Z","steps":["trace[1526919130] 'agreement among raft nodes before linearized reading' (duration: 240.283235ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T01:20:06.640862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.343106ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"warn","ts":"2026-03-06T01:20:06.640935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"399.90846ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila\" ","response":"range_response_count:1 size:3235"} {"level":"info","ts":"2026-03-06T01:20:06.640943Z","caller":"traceutil/trace.go:171","msg":"trace[297329540] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:23103; }","duration":"240.47288ms","start":"2026-03-06T01:20:06.400446Z","end":"2026-03-06T01:20:06.640919Z","steps":["trace[297329540] 'agreement among raft nodes before linearized reading' (duration: 240.264134ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T01:20:06.640977Z","caller":"traceutil/trace.go:171","msg":"trace[667704718] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila; range_end:; response_count:1; response_revision:23103; }","duration":"399.977401ms","start":"2026-03-06T01:20:06.240987Z","end":"2026-03-06T01:20:06.640965Z","steps":["trace[667704718] 'agreement among raft nodes before linearized reading' (duration: 399.874138ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T01:20:06.64101Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T01:20:06.240954Z","time spent":"400.050043ms","remote":"127.0.0.1:40242","response type":"/etcdserverpb.KV/Range","request count":0,"request size":67,"response count":1,"response size":3258,"request content":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila\" "} {"level":"warn","ts":"2026-03-06T01:20:06.64112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"604.53676ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-03-06T01:20:06.641152Z","caller":"traceutil/trace.go:171","msg":"trace[2129607726] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:23103; }","duration":"604.633351ms","start":"2026-03-06T01:20:06.036511Z","end":"2026-03-06T01:20:06.641145Z","steps":["trace[2129607726] 'agreement among raft nodes before linearized reading' (duration: 604.57926ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T01:20:06.641201Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T01:20:06.036485Z","time spent":"604.707554ms","remote":"127.0.0.1:47030","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":29,"request content":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true "} {"level":"warn","ts":"2026-03-06T01:20:06.640022Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T01:20:05.888709Z","time spent":"751.171406ms","remote":"127.0.0.1:47056","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-06T01:20:07.127317Z","caller":"traceutil/trace.go:171","msg":"trace[1614944521] transaction","detail":"{read_only:false; response_revision:23104; number_of_response:1; }","duration":"478.310548ms","start":"2026-03-06T01:20:06.648978Z","end":"2026-03-06T01:20:07.127289Z","steps":["trace[1614944521] 'process raft request' (duration: 478.125873ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T01:20:07.1275Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T01:20:06.648958Z","time spent":"478.451531ms","remote":"127.0.0.1:47056","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-06T01:20:07.137356Z","caller":"traceutil/trace.go:171","msg":"trace[566294499] transaction","detail":"{read_only:false; response_revision:23105; number_of_response:1; }","duration":"487.554086ms","start":"2026-03-06T01:20:06.649733Z","end":"2026-03-06T01:20:07.137287Z","steps":["trace[566294499] 'process raft request' (duration: 487.273849ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T01:20:07.137465Z","caller":"traceutil/trace.go:171","msg":"trace[359444654] linearizableReadLoop","detail":"{readStateIndex:23899; appliedIndex:23892; }","duration":"485.653925ms","start":"2026-03-06T01:20:06.651768Z","end":"2026-03-06T01:20:07.137421Z","steps":["trace[359444654] 'read index received' (duration: 475.490512ms)","trace[359444654] 'applied index is now lower than readState.Index' (duration: 10.161623ms)"],"step_count":2} {"level":"info","ts":"2026-03-06T01:20:07.137549Z","caller":"traceutil/trace.go:171","msg":"trace[773414569] transaction","detail":"{read_only:false; response_revision:23109; number_of_response:1; }","duration":"487.551306ms","start":"2026-03-06T01:20:06.649938Z","end":"2026-03-06T01:20:07.137489Z","steps":["trace[773414569] 'process raft request' (duration: 487.388851ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T01:20:07.137485Z","caller":"traceutil/trace.go:171","msg":"trace[587433513] transaction","detail":"{read_only:false; response_revision:23107; number_of_response:1; }","duration":"487.570736ms","start":"2026-03-06T01:20:06.649859Z","end":"2026-03-06T01:20:07.13743Z","steps":["trace[587433513] 'process raft request' (duration: 487.376951ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T01:20:07.137652Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T01:20:06.64972Z","time spent":"487.779692ms","remote":"127.0.0.1:47056","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-06T01:20:07.137708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"485.913892ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/openstack/\" range_end:\"/registry/resourcequotas/openstack0\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-03-06T01:20:07.137703Z","caller":"traceutil/trace.go:171","msg":"trace[193836200] transaction","detail":"{read_only:false; response_revision:23108; number_of_response:1; }","duration":"487.760761ms","start":"2026-03-06T01:20:06.649898Z","end":"2026-03-06T01:20:07.137659Z","steps":["trace[193836200] 'process raft request' (duration: 487.396002ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T01:20:07.137752Z","caller":"traceutil/trace.go:171","msg":"trace[1490481921] range","detail":"{range_begin:/registry/resourcequotas/openstack/; range_end:/registry/resourcequotas/openstack0; response_count:0; response_revision:23110; }","duration":"486.020944ms","start":"2026-03-06T01:20:06.651723Z","end":"2026-03-06T01:20:07.137744Z","steps":["trace[1490481921] 'agreement among raft nodes before linearized reading' (duration: 485.917482ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T01:20:07.137789Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T01:20:06.649893Z","time spent":"487.860874ms","remote":"127.0.0.1:47056","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-06T01:20:07.13779Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T01:20:06.651704Z","time spent":"486.076696ms","remote":"127.0.0.1:46924","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":0,"response size":29,"request content":"key:\"/registry/resourcequotas/openstack/\" range_end:\"/registry/resourcequotas/openstack0\" "} {"level":"warn","ts":"2026-03-06T01:20:07.137857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"470.637433ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephfilesystemmirrors/\" range_end:\"/registry/ceph.rook.io/cephfilesystemmirrors0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-03-06T01:20:07.137617Z","caller":"traceutil/trace.go:171","msg":"trace[1564852472] transaction","detail":"{read_only:false; response_revision:23110; number_of_response:1; }","duration":"486.069047ms","start":"2026-03-06T01:20:06.651537Z","end":"2026-03-06T01:20:07.137606Z","steps":["trace[1564852472] 'process raft request' (duration: 485.847701ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T01:20:07.13788Z","caller":"traceutil/trace.go:171","msg":"trace[605878901] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystemmirrors/; range_end:/registry/ceph.rook.io/cephfilesystemmirrors0; response_count:0; response_revision:23110; }","duration":"470.716815ms","start":"2026-03-06T01:20:06.667157Z","end":"2026-03-06T01:20:07.137874Z","steps":["trace[605878901] 'agreement among raft nodes before linearized reading' (duration: 470.661833ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T01:20:07.137904Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T01:20:06.667141Z","time spent":"470.758467ms","remote":"127.0.0.1:56050","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":29,"request content":"key:\"/registry/ceph.rook.io/cephfilesystemmirrors/\" range_end:\"/registry/ceph.rook.io/cephfilesystemmirrors0\" count_only:true "} {"level":"warn","ts":"2026-03-06T01:20:07.137919Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T01:20:06.651505Z","time spent":"486.382815ms","remote":"127.0.0.1:47056","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-06T01:20:07.137842Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T01:20:06.649855Z","time spent":"487.851213ms","remote":"127.0.0.1:47056","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-06T01:20:07.138071Z","caller":"traceutil/trace.go:171","msg":"trace[372013870] transaction","detail":"{read_only:false; response_revision:23106; number_of_response:1; }","duration":"488.240184ms","start":"2026-03-06T01:20:06.649821Z","end":"2026-03-06T01:20:07.138061Z","steps":["trace[372013870] 'process raft request' (duration: 487.35259ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T01:20:07.138138Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T01:20:06.649816Z","time spent":"488.287046ms","remote":"127.0.0.1:47056","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":543,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-06T01:20:07.137833Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T01:20:06.649934Z","time spent":"487.751091ms","remote":"127.0.0.1:47056","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-06T01:20:07.13827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.317973ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-03-06T01:20:07.138329Z","caller":"traceutil/trace.go:171","msg":"trace[1191142177] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:23110; }","duration":"219.407795ms","start":"2026-03-06T01:20:06.918906Z","end":"2026-03-06T01:20:07.138313Z","steps":["trace[1191142177] 'agreement among raft nodes before linearized reading' (duration: 219.257882ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T01:20:10.304149Z","caller":"traceutil/trace.go:171","msg":"trace[971800907] transaction","detail":"{read_only:false; response_revision:23132; number_of_response:1; }","duration":"132.453428ms","start":"2026-03-06T01:20:10.171672Z","end":"2026-03-06T01:20:10.304125Z","steps":["trace[971800907] 'process raft request' (duration: 132.263233ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T01:20:10.579289Z","caller":"traceutil/trace.go:171","msg":"trace[481423169] transaction","detail":"{read_only:false; response_revision:23133; number_of_response:1; }","duration":"406.14431ms","start":"2026-03-06T01:20:10.173116Z","end":"2026-03-06T01:20:10.579261Z","steps":["trace[481423169] 'process raft request' (duration: 399.303916ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T01:20:10.579274Z","caller":"traceutil/trace.go:171","msg":"trace[942992185] linearizableReadLoop","detail":"{readStateIndex:23923; appliedIndex:23921; }","duration":"368.096212ms","start":"2026-03-06T01:20:10.211117Z","end":"2026-03-06T01:20:10.579214Z","steps":["trace[942992185] 'read index received' (duration: 92.803426ms)","trace[942992185] 'applied index is now lower than readState.Index' (duration: 275.290846ms)"],"step_count":2} {"level":"warn","ts":"2026-03-06T01:20:10.579434Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T01:20:10.173089Z","time spent":"406.260253ms","remote":"127.0.0.1:47056","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":497,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-06T01:20:10.579514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.374899ms","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-03-06T01:20:10.579599Z","caller":"traceutil/trace.go:171","msg":"trace[134284831] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:23133; }","duration":"368.478181ms","start":"2026-03-06T01:20:10.2111Z","end":"2026-03-06T01:20:10.579579Z","steps":["trace[134284831] 'agreement among raft nodes before linearized reading' (duration: 368.321167ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T01:20:10.579654Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T01:20:10.211008Z","time spent":"368.634536ms","remote":"127.0.0.1:53510","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":31,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "} {"level":"warn","ts":"2026-03-06T01:20:10.579734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.552407ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-03-06T01:20:10.579844Z","caller":"traceutil/trace.go:171","msg":"trace[1548958203] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:23133; }","duration":"311.710352ms","start":"2026-03-06T01:20:10.268109Z","end":"2026-03-06T01:20:10.579819Z","steps":["trace[1548958203] 'agreement among raft nodes before linearized reading' (duration: 311.413964ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T01:20:10.57989Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T01:20:10.268094Z","time spent":"311.786443ms","remote":"127.0.0.1:43734","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":75,"response size":31,"request content":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true "} {"level":"warn","ts":"2026-03-06T01:20:10.886924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.907486ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-03-06T01:20:10.887183Z","caller":"traceutil/trace.go:171","msg":"trace[1691132177] transaction","detail":"{read_only:false; response_revision:23137; number_of_response:1; }","duration":"231.162952ms","start":"2026-03-06T01:20:10.656001Z","end":"2026-03-06T01:20:10.887163Z","steps":["trace[1691132177] 'process raft request' (duration: 231.120041ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T01:20:10.887424Z","caller":"traceutil/trace.go:171","msg":"trace[2073654721] transaction","detail":"{read_only:false; response_revision:23135; number_of_response:1; }","duration":"284.367968ms","start":"2026-03-06T01:20:10.603048Z","end":"2026-03-06T01:20:10.887416Z","steps":["trace[2073654721] 'process raft request' (duration: 283.990367ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T01:20:10.887525Z","caller":"traceutil/trace.go:171","msg":"trace[1613777601] transaction","detail":"{read_only:false; response_revision:23136; number_of_response:1; }","duration":"234.596265ms","start":"2026-03-06T01:20:10.652917Z","end":"2026-03-06T01:20:10.887513Z","steps":["trace[1613777601] 'process raft request' (duration: 234.173213ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T01:20:10.887484Z","caller":"traceutil/trace.go:171","msg":"trace[1829139322] transaction","detail":"{read_only:false; response_revision:23134; number_of_response:1; }","duration":"285.505619ms","start":"2026-03-06T01:20:10.601931Z","end":"2026-03-06T01:20:10.887437Z","steps":["trace[1829139322] 'process raft request' (duration: 103.968715ms)","trace[1829139322] 'compare' (duration: 180.380802ms)"],"step_count":2} {"level":"warn","ts":"2026-03-06T01:20:11.330629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.078818ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-03-06T01:20:11.330716Z","caller":"traceutil/trace.go:171","msg":"trace[944594448] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:23137; }","duration":"238.214532ms","start":"2026-03-06T01:20:11.092481Z","end":"2026-03-06T01:20:11.330695Z","steps":["trace[944594448] 'range keys from in-memory index tree' (duration: 237.911443ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T01:20:11.330694Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.821604ms","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-03-06T01:20:11.330803Z","caller":"traceutil/trace.go:171","msg":"trace[2050006395] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:23137; }","duration":"177.982369ms","start":"2026-03-06T01:20:11.152788Z","end":"2026-03-06T01:20:11.33077Z","steps":["trace[2050006395] 'range keys from in-memory index tree' (duration: 177.594628ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T01:20:11.330817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.644509ms","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-03-06T01:20:11.330889Z","caller":"traceutil/trace.go:171","msg":"trace[2096394127] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:23137; }","duration":"177.743552ms","start":"2026-03-06T01:20:11.153126Z","end":"2026-03-06T01:20:11.33087Z","steps":["trace[2096394127] 'range keys from in-memory index tree' (duration: 177.495165ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T01:20:11.331059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.447033ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-03-06T01:20:11.331094Z","caller":"traceutil/trace.go:171","msg":"trace[1601267950] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:23137; }","duration":"177.509495ms","start":"2026-03-06T01:20:11.153576Z","end":"2026-03-06T01:20:11.331086Z","steps":["trace[1601267950] 'range keys from in-memory index tree' (duration: 177.371041ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T01:20:11.331179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.254122ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:9"} {"level":"info","ts":"2026-03-06T01:20:11.33122Z","caller":"traceutil/trace.go:171","msg":"trace[2053265467] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:23137; }","duration":"313.339654ms","start":"2026-03-06T01:20:11.017864Z","end":"2026-03-06T01:20:11.331203Z","steps":["trace[2053265467] 'count revisions from in-memory index tree' (duration: 313.134019ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T01:20:11.331257Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T01:20:11.017842Z","time spent":"313.406856ms","remote":"127.0.0.1:47106","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":177,"response size":32,"request content":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true "} {"level":"warn","ts":"2026-03-06T01:20:11.33129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.621732ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-03-06T01:20:11.33134Z","caller":"traceutil/trace.go:171","msg":"trace[1488608495] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:23137; }","duration":"179.689493ms","start":"2026-03-06T01:20:11.151636Z","end":"2026-03-06T01:20:11.331326Z","steps":["trace[1488608495] 'range keys from in-memory index tree' (duration: 179.517019ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T01:20:11.331484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.693093ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"warn","ts":"2026-03-06T01:20:11.331509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.599327ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:557"} {"level":"info","ts":"2026-03-06T01:20:11.331534Z","caller":"traceutil/trace.go:171","msg":"trace[311087444] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:23137; }","duration":"176.760995ms","start":"2026-03-06T01:20:11.154761Z","end":"2026-03-06T01:20:11.331522Z","steps":["trace[311087444] 'range keys from in-memory index tree' (duration: 176.55949ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T01:20:11.331552Z","caller":"traceutil/trace.go:171","msg":"trace[1954899621] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:23137; }","duration":"177.655709ms","start":"2026-03-06T01:20:11.153884Z","end":"2026-03-06T01:20:11.33154Z","steps":["trace[1954899621] 'range keys from in-memory index tree' (duration: 177.496555ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T01:20:11.330842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.833405ms","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-03-06T01:20:11.33175Z","caller":"traceutil/trace.go:171","msg":"trace[1329965735] range","detail":"{range_begin:/registry/services/specs/magnum-system/; range_end:/registry/services/specs/magnum-system0; response_count:0; response_revision:23137; }","duration":"343.79334ms","start":"2026-03-06T01:20:10.987945Z","end":"2026-03-06T01:20:11.331738Z","steps":["trace[1329965735] 'range keys from in-memory index tree' (duration: 342.67363ms)"],"step_count":1} {"level":"warn","ts":"2026-03-06T01:20:11.331795Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T01:20:10.987919Z","time spent":"343.861242ms","remote":"127.0.0.1:47006","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":29,"request content":"key:\"/registry/services/specs/magnum-system/\" range_end:\"/registry/services/specs/magnum-system0\" "} {"level":"info","ts":"2026-03-06T01:20:11.486712Z","caller":"traceutil/trace.go:171","msg":"trace[1819116052] transaction","detail":"{read_only:false; response_revision:23138; number_of_response:1; }","duration":"149.301319ms","start":"2026-03-06T01:20:11.337388Z","end":"2026-03-06T01:20:11.486689Z","steps":["trace[1819116052] 'process raft request' (duration: 149.114854ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T01:20:11.487355Z","caller":"traceutil/trace.go:171","msg":"trace[1660523390] linearizableReadLoop","detail":"{readStateIndex:23933; appliedIndex:23927; }","duration":"144.038259ms","start":"2026-03-06T01:20:11.343304Z","end":"2026-03-06T01:20:11.487342Z","steps":["trace[1660523390] 'read index received' (duration: 143.182846ms)","trace[1660523390] 'applied index is now lower than readState.Index' (duration: 853.803µs)"],"step_count":2} {"level":"warn","ts":"2026-03-06T01:20:11.48746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.157282ms","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":"info","ts":"2026-03-06T01:20:11.487487Z","caller":"traceutil/trace.go:171","msg":"trace[1578797060] range","detail":"{range_begin:/registry/endpointslices/magnum-system/; range_end:/registry/endpointslices/magnum-system0; response_count:0; response_revision:23143; }","duration":"144.223014ms","start":"2026-03-06T01:20:11.343256Z","end":"2026-03-06T01:20:11.487479Z","steps":["trace[1578797060] 'agreement among raft nodes before linearized reading' (duration: 144.145332ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T01:20:11.487525Z","caller":"traceutil/trace.go:171","msg":"trace[1178792930] transaction","detail":"{read_only:false; response_revision:23140; number_of_response:1; }","duration":"149.500025ms","start":"2026-03-06T01:20:11.337994Z","end":"2026-03-06T01:20:11.487494Z","steps":["trace[1178792930] 'process raft request' (duration: 149.213748ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T01:20:11.487537Z","caller":"traceutil/trace.go:171","msg":"trace[1778934660] transaction","detail":"{read_only:false; response_revision:23142; number_of_response:1; }","duration":"149.425014ms","start":"2026-03-06T01:20:11.338093Z","end":"2026-03-06T01:20:11.487518Z","steps":["trace[1778934660] 'process raft request' (duration: 149.189678ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T01:20:11.487646Z","caller":"traceutil/trace.go:171","msg":"trace[870144428] transaction","detail":"{read_only:false; response_revision:23143; number_of_response:1; }","duration":"149.398573ms","start":"2026-03-06T01:20:11.338237Z","end":"2026-03-06T01:20:11.487635Z","steps":["trace[870144428] 'process raft request' (duration: 149.075275ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T01:20:11.487636Z","caller":"traceutil/trace.go:171","msg":"trace[1114363234] transaction","detail":"{read_only:false; response_revision:23141; number_of_response:1; }","duration":"149.527996ms","start":"2026-03-06T01:20:11.338046Z","end":"2026-03-06T01:20:11.487574Z","steps":["trace[1114363234] 'process raft request' (duration: 149.206888ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T01:20:11.487748Z","caller":"traceutil/trace.go:171","msg":"trace[691143710] transaction","detail":"{read_only:false; response_revision:23139; number_of_response:1; }","duration":"149.868315ms","start":"2026-03-06T01:20:11.33787Z","end":"2026-03-06T01:20:11.487738Z","steps":["trace[691143710] 'process raft request' (duration: 149.194237ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T01:20:12.716754Z","caller":"traceutil/trace.go:171","msg":"trace[476075821] transaction","detail":"{read_only:false; response_revision:23151; number_of_response:1; }","duration":"108.215679ms","start":"2026-03-06T01:20:12.608496Z","end":"2026-03-06T01:20:12.716712Z","steps":["trace[476075821] 'process raft request' (duration: 108.115746ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T01:20:12.716824Z","caller":"traceutil/trace.go:171","msg":"trace[1556671839] transaction","detail":"{read_only:false; response_revision:23150; number_of_response:1; }","duration":"108.61362ms","start":"2026-03-06T01:20:12.608163Z","end":"2026-03-06T01:20:12.716777Z","steps":["trace[1556671839] 'process raft request' (duration: 108.254319ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T01:20:12.89117Z","caller":"traceutil/trace.go:171","msg":"trace[1885251996] linearizableReadLoop","detail":"{readStateIndex:23942; appliedIndex:23941; }","duration":"136.019925ms","start":"2026-03-06T01:20:12.755119Z","end":"2026-03-06T01:20:12.891139Z","steps":["trace[1885251996] 'read index received' (duration: 74.64289ms)","trace[1885251996] 'applied index is now lower than readState.Index' (duration: 61.375645ms)"],"step_count":2} {"level":"info","ts":"2026-03-06T01:20:12.891189Z","caller":"traceutil/trace.go:171","msg":"trace[2053139646] transaction","detail":"{read_only:false; response_revision:23152; number_of_response:1; }","duration":"198.887268ms","start":"2026-03-06T01:20:12.692267Z","end":"2026-03-06T01:20:12.891154Z","steps":["trace[2053139646] 'process raft request' (duration: 137.592626ms)","trace[2053139646] 'compare' (duration: 61.133138ms)"],"step_count":2} {"level":"warn","ts":"2026-03-06T01:20:12.891379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.187358ms","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:6"} {"level":"info","ts":"2026-03-06T01:20:12.891883Z","caller":"traceutil/trace.go:171","msg":"trace[111144320] range","detail":"{range_begin:/registry/acme.cert-manager.io/challenges/; range_end:/registry/acme.cert-manager.io/challenges0; response_count:0; response_revision:23152; }","duration":"136.433715ms","start":"2026-03-06T01:20:12.755023Z","end":"2026-03-06T01:20:12.891457Z","steps":["trace[111144320] 'agreement among raft nodes before linearized reading' (duration: 136.224489ms)"],"step_count":1} {"level":"info","ts":"2026-03-06T01:23:20.904147Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":22106} {"level":"info","ts":"2026-03-06T01:23:21.037104Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":22106,"took":"129.044997ms","hash":2758249312,"current-db-size-bytes":50565120,"current-db-size":"51 MB","current-db-size-in-use-bytes":34299904,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-03-06T01:23:21.037194Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2758249312,"revision":22106,"compact-revision":19073} {"level":"info","ts":"2026-03-06T01:28:20.914211Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":24955} {"level":"info","ts":"2026-03-06T01:28:21.05376Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":24955,"took":"134.238935ms","hash":1869259729,"current-db-size-bytes":50565120,"current-db-size":"51 MB","current-db-size-in-use-bytes":30879744,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-03-06T01:28:21.053968Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1869259729,"revision":24955,"compact-revision":22106} {"level":"info","ts":"2026-03-06T01:32:52.03401Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"1c917701ce165bac","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-03-06T01:32:52.040077Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003} {"level":"info","ts":"2026-03-06T01:32:52.040225Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003} {"level":"info","ts":"2026-03-06T01:33:20.920402Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":27166} {"level":"info","ts":"2026-03-06T01:33:21.042861Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":27166,"took":"117.463615ms","hash":4273921542,"current-db-size-bytes":50565120,"current-db-size":"51 MB","current-db-size-in-use-bytes":27459584,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-03-06T01:33:21.042957Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4273921542,"revision":27166,"compact-revision":24955} {"level":"info","ts":"2026-03-06T01:38:20.929591Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":29236} {"level":"info","ts":"2026-03-06T01:38:21.060889Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":29236,"took":"126.783914ms","hash":1475021166,"current-db-size-bytes":50565120,"current-db-size":"51 MB","current-db-size-in-use-bytes":28917760,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-03-06T01:38:21.060989Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1475021166,"revision":29236,"compact-revision":27166} {"level":"info","ts":"2026-03-06T01:43:20.936587Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":31417} {"level":"info","ts":"2026-03-06T01:43:21.085367Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":31417,"took":"143.647046ms","hash":3786268609,"current-db-size-bytes":50565120,"current-db-size":"51 MB","current-db-size-in-use-bytes":28008448,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-03-06T01:43:21.08624Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3786268609,"revision":31417,"compact-revision":29236} {"level":"info","ts":"2026-03-06T01:48:20.945584Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":33495} {"level":"info","ts":"2026-03-06T01:48:21.076029Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":33495,"took":"125.948282ms","hash":2578823117,"current-db-size-bytes":51023872,"current-db-size":"51 MB","current-db-size-in-use-bytes":28823552,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-03-06T01:48:21.076127Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2578823117,"revision":33495,"compact-revision":31417} {"level":"info","ts":"2026-03-06T01:49:40.033832Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-00000000000091ed.wal"}