{"level":"warn","ts":"2026-07-21T20:56:52.4252Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-21T20:56:52.425277Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.235: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.235:2380","--initial-cluster=instance=https://199.204.45.235:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.235:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.235: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-07-21T20:56:52.425334Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-21T20:56:52.425349Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.235:2380"]} {"level":"info","ts":"2026-07-21T20:56:52.425368Z","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-07-21T20:56:52.426042Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.235:2379"]} {"level":"info","ts":"2026-07-21T20:56:52.426121Z","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.235:2380"],"listen-peer-urls":["https://199.204.45.235:2380"],"advertise-client-urls":["https://199.204.45.235:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.235:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.235: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-07-21T20:56:52.428435Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.131312ms"} {"level":"info","ts":"2026-07-21T20:56:52.439044Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"aab6040abcf11","cluster-id":"2bae7d3d8857c059"} {"level":"info","ts":"2026-07-21T20:56:52.439162Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 switched to configuration voters=()"} {"level":"info","ts":"2026-07-21T20:56:52.439209Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 became follower at term 0"} {"level":"info","ts":"2026-07-21T20:56:52.439242Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft aab6040abcf11 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-21T20:56:52.439264Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 became follower at term 1"} {"level":"info","ts":"2026-07-21T20:56:52.439331Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 switched to configuration voters=(3003179657318161)"} {"level":"warn","ts":"2026-07-21T20:56:52.443928Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-21T20:56:52.445562Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-21T20:56:52.447084Z","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-07-21T20:56:52.449463Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"aab6040abcf11","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-21T20:56:52.449717Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"aab6040abcf11","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-21T20:56:52.449804Z","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-07-21T20:56:52.449837Z","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-07-21T20:56:52.449847Z","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-07-21T20:56:52.450835Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 switched to configuration voters=(3003179657318161)"} {"level":"info","ts":"2026-07-21T20:56:52.451515Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"2bae7d3d8857c059","local-member-id":"aab6040abcf11","added-peer-id":"aab6040abcf11","added-peer-peer-urls":["https://199.204.45.235:2380"]} {"level":"info","ts":"2026-07-21T20:56:52.454362Z","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-07-21T20:56:52.454516Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.235:2380"} {"level":"info","ts":"2026-07-21T20:56:52.454567Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.235:2380"} {"level":"info","ts":"2026-07-21T20:56:52.45463Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"aab6040abcf11","initial-advertise-peer-urls":["https://199.204.45.235:2380"],"listen-peer-urls":["https://199.204.45.235:2380"],"advertise-client-urls":["https://199.204.45.235:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.235:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-21T20:56:52.45467Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-21T20:56:52.840385Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 is starting a new election at term 1"} {"level":"info","ts":"2026-07-21T20:56:52.840467Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 became pre-candidate at term 1"} {"level":"info","ts":"2026-07-21T20:56:52.840492Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 received MsgPreVoteResp from aab6040abcf11 at term 1"} {"level":"info","ts":"2026-07-21T20:56:52.840519Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 became candidate at term 2"} {"level":"info","ts":"2026-07-21T20:56:52.840531Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 received MsgVoteResp from aab6040abcf11 at term 2"} {"level":"info","ts":"2026-07-21T20:56:52.840548Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 became leader at term 2"} {"level":"info","ts":"2026-07-21T20:56:52.840568Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: aab6040abcf11 elected leader aab6040abcf11 at term 2"} {"level":"info","ts":"2026-07-21T20:56:52.841826Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"aab6040abcf11","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.235:2379]}","request-path":"/0/members/aab6040abcf11/attributes","cluster-id":"2bae7d3d8857c059","publish-timeout":"7s"} {"level":"info","ts":"2026-07-21T20:56:52.841841Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-21T20:56:52.841848Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-21T20:56:52.841921Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-21T20:56:52.842233Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-21T20:56:52.842316Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-21T20:56:52.844462Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"2bae7d3d8857c059","local-member-id":"aab6040abcf11","cluster-version":"3.5"} {"level":"info","ts":"2026-07-21T20:56:52.844594Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-21T20:56:52.844634Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-21T20:56:52.845401Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-21T20:56:52.864452Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.235:2379"} {"level":"warn","ts":"2026-07-21T20:57:18.30582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.502609ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-07-21T20:57:18.305999Z","caller":"traceutil/trace.go:171","msg":"trace[1715302757] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:465; }","duration":"129.737764ms","start":"2026-07-21T20:57:18.17624Z","end":"2026-07-21T20:57:18.305978Z","steps":["trace[1715302757] 'range keys from in-memory index tree' (duration: 129.373317ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T20:57:30.575549Z","caller":"traceutil/trace.go:171","msg":"trace[336272336] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"120.243524ms","start":"2026-07-21T20:57:30.455282Z","end":"2026-07-21T20:57:30.575526Z","steps":["trace[336272336] 'process raft request' (duration: 120.116511ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T20:57:30.57556Z","caller":"traceutil/trace.go:171","msg":"trace[122405729] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"121.695443ms","start":"2026-07-21T20:57:30.45383Z","end":"2026-07-21T20:57:30.575526Z","steps":["trace[122405729] 'process raft request' (duration: 118.786264ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T20:57:30.580585Z","caller":"traceutil/trace.go:171","msg":"trace[808752092] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"120.377206ms","start":"2026-07-21T20:57:30.460178Z","end":"2026-07-21T20:57:30.580555Z","steps":["trace[808752092] 'process raft request' (duration: 120.13645ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T20:57:30.581168Z","caller":"traceutil/trace.go:171","msg":"trace[20443126] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"115.167592ms","start":"2026-07-21T20:57:30.46598Z","end":"2026-07-21T20:57:30.581148Z","steps":["trace[20443126] 'process raft request' (duration: 114.972628ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T20:57:30.58124Z","caller":"traceutil/trace.go:171","msg":"trace[969115087] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"113.549769ms","start":"2026-07-21T20:57:30.467678Z","end":"2026-07-21T20:57:30.581228Z","steps":["trace[969115087] 'process raft request' (duration: 113.361466ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T20:57:30.581176Z","caller":"traceutil/trace.go:171","msg":"trace[804990319] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"120.502589ms","start":"2026-07-21T20:57:30.460653Z","end":"2026-07-21T20:57:30.581155Z","steps":["trace[804990319] 'process raft request' (duration: 119.821765ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T20:57:36.810526Z","caller":"traceutil/trace.go:171","msg":"trace[954600262] linearizableReadLoop","detail":"{readStateIndex:649; appliedIndex:648; }","duration":"272.724734ms","start":"2026-07-21T20:57:36.537769Z","end":"2026-07-21T20:57:36.810494Z","steps":["trace[954600262] 'read index received' (duration: 272.644572ms)","trace[954600262] 'applied index is now lower than readState.Index' (duration: 78.952µs)"],"step_count":2} {"level":"warn","ts":"2026-07-21T20:57:36.810714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.924419ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-21T20:57:36.810817Z","caller":"traceutil/trace.go:171","msg":"trace[1190351499] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:627; }","duration":"273.055192ms","start":"2026-07-21T20:57:36.537742Z","end":"2026-07-21T20:57:36.810797Z","steps":["trace[1190351499] 'agreement among raft nodes before linearized reading' (duration: 272.872167ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T20:57:36.811133Z","caller":"traceutil/trace.go:171","msg":"trace[1744731095] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"298.43123ms","start":"2026-07-21T20:57:36.512683Z","end":"2026-07-21T20:57:36.811115Z","steps":["trace[1744731095] 'process raft request' (duration: 297.594773ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T20:57:37.334211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.250168ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-21T20:57:37.334343Z","caller":"traceutil/trace.go:171","msg":"trace[2124485762] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:628; }","duration":"179.399151ms","start":"2026-07-21T20:57:37.154925Z","end":"2026-07-21T20:57:37.334324Z","steps":["trace[2124485762] 'range keys from in-memory index tree' (duration: 179.231188ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T20:57:37.335072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.936053ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-21T20:57:37.335308Z","caller":"traceutil/trace.go:171","msg":"trace[1174155895] linearizableReadLoop","detail":"{readStateIndex:652; appliedIndex:650; }","duration":"230.417004ms","start":"2026-07-21T20:57:37.104876Z","end":"2026-07-21T20:57:37.335293Z","steps":["trace[1174155895] 'read index received' (duration: 46.772168ms)","trace[1174155895] 'applied index is now lower than readState.Index' (duration: 183.643836ms)"],"step_count":2} {"level":"warn","ts":"2026-07-21T20:57:37.335517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.64761ms","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-07-21T20:57:37.335604Z","caller":"traceutil/trace.go:171","msg":"trace[765074553] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:630; }","duration":"230.770941ms","start":"2026-07-21T20:57:37.104822Z","end":"2026-07-21T20:57:37.335593Z","steps":["trace[765074553] 'agreement among raft nodes before linearized reading' (duration: 230.562267ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T20:57:37.335459Z","caller":"traceutil/trace.go:171","msg":"trace[2102082611] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"432.801188ms","start":"2026-07-21T20:57:36.902603Z","end":"2026-07-21T20:57:37.335404Z","steps":["trace[2102082611] 'process raft request' (duration: 432.618794ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T20:57:37.335484Z","caller":"traceutil/trace.go:171","msg":"trace[1312873875] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"483.790381ms","start":"2026-07-21T20:57:36.851654Z","end":"2026-07-21T20:57:37.335444Z","steps":["trace[1312873875] 'process raft request' (duration: 138.879338ms)","trace[1312873875] 'compare' (duration: 343.75558ms)"],"step_count":2} {"level":"warn","ts":"2026-07-21T20:57:37.33587Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T20:57:36.902581Z","time spent":"433.213686ms","remote":"127.0.0.1:37570","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":897,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-21T20:57:37.336026Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T20:57:36.851625Z","time spent":"484.307871ms","remote":"127.0.0.1:37486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-21T20:58:18.966285Z","caller":"traceutil/trace.go:171","msg":"trace[2017379478] transaction","detail":"{read_only:false; response_revision:1190; number_of_response:1; }","duration":"244.442053ms","start":"2026-07-21T20:58:18.721782Z","end":"2026-07-21T20:58:18.966224Z","steps":["trace[2017379478] 'process raft request' (duration: 244.226438ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T20:58:18.97118Z","caller":"traceutil/trace.go:171","msg":"trace[1440230192] linearizableReadLoop","detail":"{readStateIndex:1223; appliedIndex:1221; }","duration":"247.314179ms","start":"2026-07-21T20:58:18.723851Z","end":"2026-07-21T20:58:18.971165Z","steps":["trace[1440230192] 'read index received' (duration: 242.173857ms)","trace[1440230192] 'applied index is now lower than readState.Index' (duration: 5.139582ms)"],"step_count":2} {"level":"info","ts":"2026-07-21T20:58:18.971279Z","caller":"traceutil/trace.go:171","msg":"trace[282919264] transaction","detail":"{read_only:false; response_revision:1191; number_of_response:1; }","duration":"247.732719ms","start":"2026-07-21T20:58:18.723513Z","end":"2026-07-21T20:58:18.971245Z","steps":["trace[282919264] 'process raft request' (duration: 247.567835ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T20:58:18.97132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.461103ms","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-07-21T20:58:18.9715Z","caller":"traceutil/trace.go:171","msg":"trace[255370253] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1191; }","duration":"247.638697ms","start":"2026-07-21T20:58:18.723803Z","end":"2026-07-21T20:58:18.971442Z","steps":["trace[255370253] 'agreement among raft nodes before linearized reading' (duration: 247.431833ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T20:59:03.023733Z","caller":"traceutil/trace.go:171","msg":"trace[1709609322] transaction","detail":"{read_only:false; response_revision:1844; number_of_response:1; }","duration":"231.005251ms","start":"2026-07-21T20:59:02.7927Z","end":"2026-07-21T20:59:03.023706Z","steps":["trace[1709609322] 'process raft request' (duration: 230.810497ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T20:59:03.127319Z","caller":"traceutil/trace.go:171","msg":"trace[1614084603] linearizableReadLoop","detail":"{readStateIndex:1913; appliedIndex:1911; }","duration":"187.701697ms","start":"2026-07-21T20:59:02.939593Z","end":"2026-07-21T20:59:03.127295Z","steps":["trace[1614084603] 'read index received' (duration: 83.912333ms)","trace[1614084603] 'applied index is now lower than readState.Index' (duration: 103.788364ms)"],"step_count":2} {"level":"info","ts":"2026-07-21T20:59:03.127424Z","caller":"traceutil/trace.go:171","msg":"trace[733289220] transaction","detail":"{read_only:false; response_revision:1845; number_of_response:1; }","duration":"245.889321ms","start":"2026-07-21T20:59:02.881497Z","end":"2026-07-21T20:59:03.127386Z","steps":["trace[733289220] 'process raft request' (duration: 185.465642ms)","trace[733289220] 'compare' (duration: 60.215485ms)"],"step_count":2} {"level":"warn","ts":"2026-07-21T20:59:03.127693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.557669ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-48304791-e6c0-41f2-973d-e2e93c633053\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-07-21T20:59:03.127787Z","caller":"traceutil/trace.go:171","msg":"trace[510178895] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-48304791-e6c0-41f2-973d-e2e93c633053; range_end:; response_count:1; response_revision:1845; }","duration":"155.705782ms","start":"2026-07-21T20:59:02.972057Z","end":"2026-07-21T20:59:03.127763Z","steps":["trace[510178895] 'agreement among raft nodes before linearized reading' (duration: 155.449267ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T20:59:03.128148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.534574ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-48304791-e6c0-41f2-973d-e2e93c633053\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-07-21T20:59:03.128259Z","caller":"traceutil/trace.go:171","msg":"trace[863608825] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-48304791-e6c0-41f2-973d-e2e93c633053; range_end:; response_count:1; response_revision:1845; }","duration":"188.682746ms","start":"2026-07-21T20:59:02.939559Z","end":"2026-07-21T20:59:03.128242Z","steps":["trace[863608825] 'agreement among raft nodes before linearized reading' (duration: 187.86888ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T20:59:03.271376Z","caller":"traceutil/trace.go:171","msg":"trace[396968658] transaction","detail":"{read_only:false; response_revision:1847; number_of_response:1; }","duration":"135.109826ms","start":"2026-07-21T20:59:03.136231Z","end":"2026-07-21T20:59:03.27134Z","steps":["trace[396968658] 'process raft request' (duration: 101.455407ms)","trace[396968658] 'compare' (duration: 33.416024ms)"],"step_count":2} {"level":"info","ts":"2026-07-21T20:59:03.271407Z","caller":"traceutil/trace.go:171","msg":"trace[1477696919] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1847; }","duration":"100.015197ms","start":"2026-07-21T20:59:03.171369Z","end":"2026-07-21T20:59:03.271384Z","steps":["trace[1477696919] 'agreement among raft nodes before linearized reading' (duration: 99.851924ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T20:59:03.522138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.690466ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-21T20:59:03.522415Z","caller":"traceutil/trace.go:171","msg":"trace[1753546296] transaction","detail":"{read_only:false; response_revision:1851; number_of_response:1; }","duration":"140.826564ms","start":"2026-07-21T20:59:03.381564Z","end":"2026-07-21T20:59:03.52239Z","steps":["trace[1753546296] 'process raft request' (duration: 140.771463ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T20:59:03.522406Z","caller":"traceutil/trace.go:171","msg":"trace[1672844648] transaction","detail":"{read_only:false; response_revision:1849; number_of_response:1; }","duration":"245.406772ms","start":"2026-07-21T20:59:03.276965Z","end":"2026-07-21T20:59:03.522372Z","steps":["trace[1672844648] 'process raft request' (duration: 142.363718ms)","trace[1672844648] 'compare' (duration: 102.553174ms)"],"step_count":2} {"level":"info","ts":"2026-07-21T20:59:03.522461Z","caller":"traceutil/trace.go:171","msg":"trace[1329843929] transaction","detail":"{read_only:false; response_revision:1850; number_of_response:1; }","duration":"245.466333ms","start":"2026-07-21T20:59:03.276957Z","end":"2026-07-21T20:59:03.522423Z","steps":["trace[1329843929] 'process raft request' (duration: 245.298719ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T20:59:51.364993Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.171084ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:26"} {"level":"info","ts":"2026-07-21T20:59:51.365125Z","caller":"traceutil/trace.go:171","msg":"trace[2146748280] linearizableReadLoop","detail":"{readStateIndex:2232; appliedIndex:2231; }","duration":"102.963502ms","start":"2026-07-21T20:59:51.262144Z","end":"2026-07-21T20:59:51.365107Z","steps":["trace[2146748280] 'read index received' (duration: 26.751µs)","trace[2146748280] 'applied index is now lower than readState.Index' (duration: 102.935071ms)"],"step_count":2} {"level":"warn","ts":"2026-07-21T20:59:51.365283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.130615ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-07-21T20:59:51.365315Z","caller":"traceutil/trace.go:171","msg":"trace[3248835] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2153; }","duration":"103.196187ms","start":"2026-07-21T20:59:51.262108Z","end":"2026-07-21T20:59:51.365304Z","steps":["trace[3248835] 'agreement among raft nodes before linearized reading' (duration: 103.049574ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T20:59:51.436423Z","caller":"traceutil/trace.go:171","msg":"trace[1654333458] transaction","detail":"{read_only:false; response_revision:2154; number_of_response:1; }","duration":"132.303362ms","start":"2026-07-21T20:59:51.304095Z","end":"2026-07-21T20:59:51.436399Z","steps":["trace[1654333458] 'process raft request' (duration: 132.145728ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:04:57.524356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.656605ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-21T21:04:57.524543Z","caller":"traceutil/trace.go:171","msg":"trace[778276429] linearizableReadLoop","detail":"{readStateIndex:5079; appliedIndex:5077; }","duration":"127.412479ms","start":"2026-07-21T21:04:57.397113Z","end":"2026-07-21T21:04:57.524526Z","steps":["trace[778276429] 'read index received' (duration: 123.998538ms)","trace[778276429] 'applied index is now lower than readState.Index' (duration: 3.413011ms)"],"step_count":2} {"level":"info","ts":"2026-07-21T21:04:57.524577Z","caller":"traceutil/trace.go:171","msg":"trace[897699388] transaction","detail":"{read_only:false; response_revision:4898; number_of_response:1; }","duration":"254.516551ms","start":"2026-07-21T21:04:57.270031Z","end":"2026-07-21T21:04:57.524548Z","steps":["trace[897699388] 'process raft request' (duration: 254.43596ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:04:57.524597Z","caller":"traceutil/trace.go:171","msg":"trace[1910327457] transaction","detail":"{read_only:false; response_revision:4897; number_of_response:1; }","duration":"254.629884ms","start":"2026-07-21T21:04:57.269934Z","end":"2026-07-21T21:04:57.524564Z","steps":["trace[1910327457] 'process raft request' (duration: 123.683963ms)","trace[1910327457] 'compare' (duration: 130.530691ms)"],"step_count":2} {"level":"warn","ts":"2026-07-21T21:04:57.524661Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.529552ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/monitoring/vector\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-21T21:04:57.524722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.450011ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-9054f796-4fe8-43d2-9b5b-95ddaf13d599\" ","response":"range_response_count:1 size:3601"} {"level":"info","ts":"2026-07-21T21:04:57.524733Z","caller":"traceutil/trace.go:171","msg":"trace[68672417] range","detail":"{range_begin:/registry/serviceaccounts/monitoring/vector; range_end:; response_count:0; response_revision:4898; }","duration":"127.608664ms","start":"2026-07-21T21:04:57.397107Z","end":"2026-07-21T21:04:57.524716Z","steps":["trace[68672417] 'agreement among raft nodes before linearized reading' (duration: 127.491881ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:04:57.524757Z","caller":"traceutil/trace.go:171","msg":"trace[1839076157] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-9054f796-4fe8-43d2-9b5b-95ddaf13d599; range_end:; response_count:1; response_revision:4898; }","duration":"108.485301ms","start":"2026-07-21T21:04:57.416261Z","end":"2026-07-21T21:04:57.524746Z","steps":["trace[1839076157] 'agreement among raft nodes before linearized reading' (duration: 108.362539ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:04:59.991929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.297345ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:5"} {"level":"info","ts":"2026-07-21T21:04:59.992105Z","caller":"traceutil/trace.go:171","msg":"trace[756956285] transaction","detail":"{read_only:false; number_of_response:0; response_revision:4941; }","duration":"219.971944ms","start":"2026-07-21T21:04:59.77211Z","end":"2026-07-21T21:04:59.992082Z","steps":["trace[756956285] 'process raft request' (duration: 115.409113ms)","trace[756956285] 'compare' (duration: 104.198473ms)"],"step_count":2} {"level":"info","ts":"2026-07-21T21:05:10.94505Z","caller":"traceutil/trace.go:171","msg":"trace[1016212538] transaction","detail":"{read_only:false; response_revision:5170; number_of_response:1; }","duration":"308.69433ms","start":"2026-07-21T21:05:10.636265Z","end":"2026-07-21T21:05:10.94496Z","steps":["trace[1016212538] 'process raft request' (duration: 308.527027ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:05:10.945414Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T21:05:10.636238Z","time spent":"308.906854ms","remote":"127.0.0.1:37486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-21T21:05:10.952589Z","caller":"traceutil/trace.go:171","msg":"trace[447951144] transaction","detail":"{read_only:false; response_revision:5171; number_of_response:1; }","duration":"266.357264ms","start":"2026-07-21T21:05:10.686202Z","end":"2026-07-21T21:05:10.952559Z","steps":["trace[447951144] 'process raft request' (duration: 266.138569ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:05:10.952758Z","caller":"traceutil/trace.go:171","msg":"trace[1586681538] linearizableReadLoop","detail":"{readStateIndex:5359; appliedIndex:5357; }","duration":"165.328355ms","start":"2026-07-21T21:05:10.787408Z","end":"2026-07-21T21:05:10.952736Z","steps":["trace[1586681538] 'read index received' (duration: 157.442593ms)","trace[1586681538] 'applied index is now lower than readState.Index' (duration: 7.883942ms)"],"step_count":2} {"level":"warn","ts":"2026-07-21T21:05:10.953252Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.792715ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/memcached-memcached-6479589586-cwfbn\" ","response":"range_response_count:1 size:7818"} {"level":"info","ts":"2026-07-21T21:05:10.953382Z","caller":"traceutil/trace.go:171","msg":"trace[45477951] range","detail":"{range_begin:/registry/pods/openstack/memcached-memcached-6479589586-cwfbn; range_end:; response_count:1; response_revision:5172; }","duration":"164.928907ms","start":"2026-07-21T21:05:10.788402Z","end":"2026-07-21T21:05:10.953331Z","steps":["trace[45477951] 'agreement among raft nodes before linearized reading' (duration: 164.651702ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:05:10.953263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.832195ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:559"} {"level":"info","ts":"2026-07-21T21:05:10.953575Z","caller":"traceutil/trace.go:171","msg":"trace[2028713976] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:5172; }","duration":"166.145951ms","start":"2026-07-21T21:05:10.7874Z","end":"2026-07-21T21:05:10.953546Z","steps":["trace[2028713976] 'agreement among raft nodes before linearized reading' (duration: 165.525539ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:05:18.201993Z","caller":"traceutil/trace.go:171","msg":"trace[398640965] transaction","detail":"{read_only:false; response_revision:5343; number_of_response:1; }","duration":"218.132227ms","start":"2026-07-21T21:05:17.983825Z","end":"2026-07-21T21:05:18.201957Z","steps":["trace[398640965] 'process raft request' (duration: 132.240998ms)","trace[398640965] 'compare' (duration: 85.753866ms)"],"step_count":2} {"level":"info","ts":"2026-07-21T21:05:18.444191Z","caller":"traceutil/trace.go:171","msg":"trace[341699481] transaction","detail":"{read_only:false; response_revision:5351; number_of_response:1; }","duration":"149.358307ms","start":"2026-07-21T21:05:18.294806Z","end":"2026-07-21T21:05:18.444164Z","steps":["trace[341699481] 'process raft request' (duration: 57.887615ms)","trace[341699481] 'compare' (duration: 91.34787ms)"],"step_count":2} {"level":"info","ts":"2026-07-21T21:05:18.468343Z","caller":"traceutil/trace.go:171","msg":"trace[135506664] transaction","detail":"{read_only:false; response_revision:5352; number_of_response:1; }","duration":"172.429231ms","start":"2026-07-21T21:05:18.295887Z","end":"2026-07-21T21:05:18.468317Z","steps":["trace[135506664] 'process raft request' (duration: 172.220306ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:05:18.468611Z","caller":"traceutil/trace.go:171","msg":"trace[1549134940] transaction","detail":"{read_only:false; response_revision:5353; number_of_response:1; }","duration":"172.564524ms","start":"2026-07-21T21:05:18.296017Z","end":"2026-07-21T21:05:18.468582Z","steps":["trace[1549134940] 'process raft request' (duration: 172.233667ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:05:18.469218Z","caller":"traceutil/trace.go:171","msg":"trace[897722766] transaction","detail":"{read_only:false; response_revision:5355; number_of_response:1; }","duration":"171.885419ms","start":"2026-07-21T21:05:18.297295Z","end":"2026-07-21T21:05:18.469181Z","steps":["trace[897722766] 'process raft request' (duration: 171.797067ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:05:18.469452Z","caller":"traceutil/trace.go:171","msg":"trace[869947059] transaction","detail":"{read_only:false; response_revision:5354; number_of_response:1; }","duration":"172.366409ms","start":"2026-07-21T21:05:18.297058Z","end":"2026-07-21T21:05:18.469425Z","steps":["trace[869947059] 'process raft request' (duration: 171.43083ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:05:27.817942Z","caller":"traceutil/trace.go:171","msg":"trace[1607813385] transaction","detail":"{read_only:false; response_revision:5472; number_of_response:1; }","duration":"109.490541ms","start":"2026-07-21T21:05:27.708428Z","end":"2026-07-21T21:05:27.817919Z","steps":["trace[1607813385] 'process raft request' (duration: 109.371989ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:05:27.818268Z","caller":"traceutil/trace.go:171","msg":"trace[920796538] transaction","detail":"{read_only:false; response_revision:5471; number_of_response:1; }","duration":"155.370881ms","start":"2026-07-21T21:05:27.662861Z","end":"2026-07-21T21:05:27.818232Z","steps":["trace[920796538] 'process raft request' (duration: 85.298406ms)","trace[920796538] 'compare' (duration: 69.465662ms)"],"step_count":2} {"level":"info","ts":"2026-07-21T21:06:52.873452Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3014} {"level":"info","ts":"2026-07-21T21:06:52.969959Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3014,"took":"94.970596ms","hash":178272423,"current-db-size-bytes":59244544,"current-db-size":"59 MB","current-db-size-in-use-bytes":32387072,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-07-21T21:06:52.970041Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":178272423,"revision":3014,"compact-revision":-1} {"level":"warn","ts":"2026-07-21T21:11:22.674353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.992063ms","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:7"} {"level":"info","ts":"2026-07-21T21:11:22.674445Z","caller":"traceutil/trace.go:171","msg":"trace[1220603318] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:8146; }","duration":"289.133716ms","start":"2026-07-21T21:11:22.385293Z","end":"2026-07-21T21:11:22.674426Z","steps":["trace[1220603318] 'count revisions from in-memory index tree' (duration: 288.852351ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:11:52.882451Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6171} {"level":"info","ts":"2026-07-21T21:11:52.982704Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6171,"took":"98.888337ms","hash":4149324995,"current-db-size-bytes":59244544,"current-db-size":"59 MB","current-db-size-in-use-bytes":23080960,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-07-21T21:11:52.982758Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4149324995,"revision":6171,"compact-revision":3014} {"level":"info","ts":"2026-07-21T21:12:02.768805Z","caller":"traceutil/trace.go:171","msg":"trace[1106410494] transaction","detail":"{read_only:false; number_of_response:1; response_revision:8451; }","duration":"230.681337ms","start":"2026-07-21T21:12:02.538097Z","end":"2026-07-21T21:12:02.768779Z","steps":["trace[1106410494] 'process raft request' (duration: 136.998385ms)","trace[1106410494] 'compare' (duration: 93.211982ms)"],"step_count":2} {"level":"info","ts":"2026-07-21T21:12:02.848869Z","caller":"traceutil/trace.go:171","msg":"trace[1949129259] transaction","detail":"{read_only:false; response_revision:8452; number_of_response:1; }","duration":"310.172528ms","start":"2026-07-21T21:12:02.538665Z","end":"2026-07-21T21:12:02.848837Z","steps":["trace[1949129259] 'process raft request' (duration: 309.958014ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:12:02.84896Z","caller":"traceutil/trace.go:171","msg":"trace[536351450] linearizableReadLoop","detail":"{readStateIndex:8751; appliedIndex:8748; }","duration":"307.170997ms","start":"2026-07-21T21:12:02.541747Z","end":"2026-07-21T21:12:02.848918Z","steps":["trace[536351450] 'read index received' (duration: 133.434172ms)","trace[536351450] 'applied index is now lower than readState.Index' (duration: 173.731745ms)"],"step_count":2} {"level":"info","ts":"2026-07-21T21:12:02.848931Z","caller":"traceutil/trace.go:171","msg":"trace[1190268879] transaction","detail":"{read_only:false; response_revision:8453; number_of_response:1; }","duration":"308.879802ms","start":"2026-07-21T21:12:02.540038Z","end":"2026-07-21T21:12:02.848918Z","steps":["trace[1190268879] 'process raft request' (duration: 308.727229ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:12:02.849106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.317361ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-21T21:12:02.849172Z","caller":"traceutil/trace.go:171","msg":"trace[2118964931] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8453; }","duration":"307.431493ms","start":"2026-07-21T21:12:02.541727Z","end":"2026-07-21T21:12:02.849159Z","steps":["trace[2118964931] 'agreement among raft nodes before linearized reading' (duration: 307.29398ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:12:02.849193Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T21:12:02.540031Z","time spent":"309.067276ms","remote":"127.0.0.1:37486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-21T21:12:02.849308Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T21:12:02.538659Z","time spent":"310.387562ms","remote":"127.0.0.1:37402","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4653,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-21T21:12:02.849223Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T21:12:02.541719Z","time spent":"307.493974ms","remote":"127.0.0.1:37282","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-21T21:12:02.880677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.127976ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/queues/\" range_end:\"/registry/rabbitmq.com/queues0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-21T21:12:02.880861Z","caller":"traceutil/trace.go:171","msg":"trace[516220534] range","detail":"{range_begin:/registry/rabbitmq.com/queues/; range_end:/registry/rabbitmq.com/queues0; response_count:0; response_revision:8454; }","duration":"282.34413ms","start":"2026-07-21T21:12:02.59849Z","end":"2026-07-21T21:12:02.880834Z","steps":["trace[516220534] 'agreement among raft nodes before linearized reading' (duration: 282.090224ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:12:02.881124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.990029ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-zpql7\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-07-21T21:12:02.881198Z","caller":"traceutil/trace.go:171","msg":"trace[212263191] range","detail":"{range_begin:/registry/pods/openstack/keepalived-zpql7; range_end:; response_count:1; response_revision:8454; }","duration":"322.081661ms","start":"2026-07-21T21:12:02.559097Z","end":"2026-07-21T21:12:02.881178Z","steps":["trace[212263191] 'agreement among raft nodes before linearized reading' (duration: 321.899327ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:12:02.881243Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T21:12:02.559088Z","time spent":"322.140832ms","remote":"127.0.0.1:37402","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6545,"request content":"key:\"/registry/pods/openstack/keepalived-zpql7\" "} {"level":"info","ts":"2026-07-21T21:12:46.778522Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002404.wal"} {"level":"info","ts":"2026-07-21T21:14:18.461943Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"aab6040abcf11","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-07-21T21:14:18.466678Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-07-21T21:14:18.466773Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-07-21T21:16:48.858502Z","caller":"traceutil/trace.go:171","msg":"trace[2119456664] linearizableReadLoop","detail":"{readStateIndex:11385; appliedIndex:11384; }","duration":"187.594618ms","start":"2026-07-21T21:16:48.670879Z","end":"2026-07-21T21:16:48.858473Z","steps":["trace[2119456664] 'read index received' (duration: 187.397454ms)","trace[2119456664] 'applied index is now lower than readState.Index' (duration: 195.664µs)"],"step_count":2} {"level":"info","ts":"2026-07-21T21:16:48.858841Z","caller":"traceutil/trace.go:171","msg":"trace[2039346922] transaction","detail":"{read_only:false; response_revision:11014; number_of_response:1; }","duration":"213.238076ms","start":"2026-07-21T21:16:48.64559Z","end":"2026-07-21T21:16:48.858828Z","steps":["trace[2039346922] 'process raft request' (duration: 212.673104ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:16:48.859292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.748596ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-zpql7\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-07-21T21:16:48.859375Z","caller":"traceutil/trace.go:171","msg":"trace[804884208] range","detail":"{range_begin:/registry/pods/openstack/keepalived-zpql7; range_end:; response_count:1; response_revision:11014; }","duration":"116.896289ms","start":"2026-07-21T21:16:48.742461Z","end":"2026-07-21T21:16:48.859358Z","steps":["trace[804884208] 'agreement among raft nodes before linearized reading' (duration: 116.647024ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:16:48.859694Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.511408ms","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-07-21T21:16:48.859762Z","caller":"traceutil/trace.go:171","msg":"trace[716825860] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:11014; }","duration":"188.885816ms","start":"2026-07-21T21:16:48.670862Z","end":"2026-07-21T21:16:48.859747Z","steps":["trace[716825860] 'agreement among raft nodes before linearized reading' (duration: 188.432756ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:16:49.389946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.714546ms","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-07-21T21:16:49.390032Z","caller":"traceutil/trace.go:171","msg":"trace[1817060118] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:11017; }","duration":"100.960581ms","start":"2026-07-21T21:16:49.28905Z","end":"2026-07-21T21:16:49.390011Z","steps":["trace[1817060118] 'range keys from in-memory index tree' (duration: 100.481142ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:16:52.890841Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8361} {"level":"info","ts":"2026-07-21T21:16:52.971006Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8361,"took":"77.634942ms","hash":2217269996,"current-db-size-bytes":59244544,"current-db-size":"59 MB","current-db-size-in-use-bytes":26943488,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-07-21T21:16:52.971102Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2217269996,"revision":8361,"compact-revision":6171} {"level":"info","ts":"2026-07-21T21:21:52.898308Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":11038} {"level":"info","ts":"2026-07-21T21:21:52.980925Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":11038,"took":"79.599256ms","hash":3676664158,"current-db-size-bytes":59244544,"current-db-size":"59 MB","current-db-size-in-use-bytes":27910144,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-07-21T21:21:52.980976Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3676664158,"revision":11038,"compact-revision":8361} {"level":"info","ts":"2026-07-21T21:22:38.870543Z","caller":"traceutil/trace.go:171","msg":"trace[528561768] transaction","detail":"{read_only:false; response_revision:13412; number_of_response:1; }","duration":"121.21398ms","start":"2026-07-21T21:22:38.749304Z","end":"2026-07-21T21:22:38.870518Z","steps":["trace[528561768] 'process raft request' (duration: 121.086267ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:22:38.871981Z","caller":"traceutil/trace.go:171","msg":"trace[586372734] transaction","detail":"{read_only:false; response_revision:13413; number_of_response:1; }","duration":"122.340472ms","start":"2026-07-21T21:22:38.749625Z","end":"2026-07-21T21:22:38.871965Z","steps":["trace[586372734] 'process raft request' (duration: 122.26336ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:23:11.813088Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.435284ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:559"} {"level":"info","ts":"2026-07-21T21:23:11.813176Z","caller":"traceutil/trace.go:171","msg":"trace[102727847] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:13598; }","duration":"121.572677ms","start":"2026-07-21T21:23:11.691584Z","end":"2026-07-21T21:23:11.813156Z","steps":["trace[102727847] 'range keys from in-memory index tree' (duration: 121.209889ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:23:12.785088Z","caller":"traceutil/trace.go:171","msg":"trace[994830195] linearizableReadLoop","detail":"{readStateIndex:14064; appliedIndex:14063; }","duration":"246.868661ms","start":"2026-07-21T21:23:12.538197Z","end":"2026-07-21T21:23:12.785066Z","steps":["trace[994830195] 'read index received' (duration: 246.635706ms)","trace[994830195] 'applied index is now lower than readState.Index' (duration: 231.845µs)"],"step_count":2} {"level":"info","ts":"2026-07-21T21:23:12.785142Z","caller":"traceutil/trace.go:171","msg":"trace[2068948376] transaction","detail":"{read_only:false; response_revision:13600; number_of_response:1; }","duration":"303.053065ms","start":"2026-07-21T21:23:12.482046Z","end":"2026-07-21T21:23:12.785099Z","steps":["trace[2068948376] 'process raft request' (duration: 302.875612ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:23:12.785283Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T21:23:12.482029Z","time spent":"303.177227ms","remote":"127.0.0.1:37402","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":12483,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-21T21:23:12.785291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.083146ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-21T21:23:12.785387Z","caller":"traceutil/trace.go:171","msg":"trace[724324811] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:13600; }","duration":"247.232118ms","start":"2026-07-21T21:23:12.538143Z","end":"2026-07-21T21:23:12.785375Z","steps":["trace[724324811] 'agreement among raft nodes before linearized reading' (duration: 247.050854ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:23:21.824374Z","caller":"traceutil/trace.go:171","msg":"trace[1042905031] transaction","detail":"{read_only:false; response_revision:13764; number_of_response:1; }","duration":"226.180647ms","start":"2026-07-21T21:23:21.598167Z","end":"2026-07-21T21:23:21.824348Z","steps":["trace[1042905031] 'process raft request' (duration: 226.013183ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:23:22.048649Z","caller":"traceutil/trace.go:171","msg":"trace[633924832] linearizableReadLoop","detail":"{readStateIndex:14232; appliedIndex:14230; }","duration":"365.363945ms","start":"2026-07-21T21:23:21.683247Z","end":"2026-07-21T21:23:22.04861Z","steps":["trace[633924832] 'read index received' (duration: 140.967226ms)","trace[633924832] 'applied index is now lower than readState.Index' (duration: 224.394949ms)"],"step_count":2} {"level":"info","ts":"2026-07-21T21:23:22.048682Z","caller":"traceutil/trace.go:171","msg":"trace[1592922353] transaction","detail":"{read_only:false; response_revision:13765; number_of_response:1; }","duration":"438.395514ms","start":"2026-07-21T21:23:21.610264Z","end":"2026-07-21T21:23:22.04866Z","steps":["trace[1592922353] 'process raft request' (duration: 433.744958ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:23:22.048884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.6362ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rook-ceph-pdbstatemap\" ","response":"range_response_count:1 size:356"} {"level":"info","ts":"2026-07-21T21:23:22.048913Z","caller":"traceutil/trace.go:171","msg":"trace[138925990] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-pdbstatemap; range_end:; response_count:1; response_revision:13765; }","duration":"365.719152ms","start":"2026-07-21T21:23:21.683188Z","end":"2026-07-21T21:23:22.048907Z","steps":["trace[138925990] 'agreement among raft nodes before linearized reading' (duration: 365.542479ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:23:22.048935Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T21:23:21.683156Z","time spent":"365.774323ms","remote":"127.0.0.1:37346","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":377,"request content":"key:\"/registry/configmaps/openstack/rook-ceph-pdbstatemap\" "} {"level":"warn","ts":"2026-07-21T21:23:22.048945Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T21:23:21.610243Z","time spent":"438.569118ms","remote":"127.0.0.1:37330","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":774,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-21T21:23:22.049159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.275604ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-21T21:23:22.049256Z","caller":"traceutil/trace.go:171","msg":"trace[716384326] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:13765; }","duration":"275.593801ms","start":"2026-07-21T21:23:21.773645Z","end":"2026-07-21T21:23:22.049239Z","steps":["trace[716384326] 'agreement among raft nodes before linearized reading' (duration: 275.259144ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:23:22.049276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.240295ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c8b4664d-d96a-49e6-ae41-f88d9c2a4f57\" ","response":"range_response_count:1 size:3607"} {"level":"info","ts":"2026-07-21T21:23:22.049355Z","caller":"traceutil/trace.go:171","msg":"trace[1032827980] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-c8b4664d-d96a-49e6-ae41-f88d9c2a4f57; range_end:; response_count:1; response_revision:13765; }","duration":"221.377308ms","start":"2026-07-21T21:23:21.827956Z","end":"2026-07-21T21:23:22.049333Z","steps":["trace[1032827980] 'agreement among raft nodes before linearized reading' (duration: 221.133983ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:23:22.049355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.413363ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-zpql7\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-07-21T21:23:22.049483Z","caller":"traceutil/trace.go:171","msg":"trace[565915044] range","detail":"{range_begin:/registry/pods/openstack/keepalived-zpql7; range_end:; response_count:1; response_revision:13765; }","duration":"122.594757ms","start":"2026-07-21T21:23:21.92686Z","end":"2026-07-21T21:23:22.049455Z","steps":["trace[565915044] 'agreement among raft nodes before linearized reading' (duration: 122.23574ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:24:59.167505Z","caller":"traceutil/trace.go:171","msg":"trace[1236738929] transaction","detail":"{read_only:false; response_revision:14835; number_of_response:1; }","duration":"143.481365ms","start":"2026-07-21T21:24:59.023991Z","end":"2026-07-21T21:24:59.167472Z","steps":["trace[1236738929] 'process raft request' (duration: 114.121512ms)","trace[1236738929] 'compare' (duration: 29.24042ms)"],"step_count":2} {"level":"info","ts":"2026-07-21T21:24:59.46063Z","caller":"traceutil/trace.go:171","msg":"trace[415728563] transaction","detail":"{read_only:false; response_revision:14836; number_of_response:1; }","duration":"128.645431ms","start":"2026-07-21T21:24:59.331958Z","end":"2026-07-21T21:24:59.460604Z","steps":["trace[415728563] 'process raft request' (duration: 128.488058ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:24:59.463531Z","caller":"traceutil/trace.go:171","msg":"trace[1103361561] transaction","detail":"{read_only:false; response_revision:14837; number_of_response:1; }","duration":"119.511724ms","start":"2026-07-21T21:24:59.344Z","end":"2026-07-21T21:24:59.463512Z","steps":["trace[1103361561] 'process raft request' (duration: 119.275709ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:24:59.463663Z","caller":"traceutil/trace.go:171","msg":"trace[728650363] transaction","detail":"{read_only:false; response_revision:14838; number_of_response:1; }","duration":"119.362491ms","start":"2026-07-21T21:24:59.344259Z","end":"2026-07-21T21:24:59.463622Z","steps":["trace[728650363] 'process raft request' (duration: 119.141106ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:26:52.907166Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":13097} {"level":"info","ts":"2026-07-21T21:26:52.983904Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":13097,"took":"74.372626ms","hash":976767134,"current-db-size-bytes":59244544,"current-db-size":"59 MB","current-db-size-in-use-bytes":31420416,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-07-21T21:26:52.983963Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":976767134,"revision":13097,"compact-revision":11038} {"level":"info","ts":"2026-07-21T21:30:39.042662Z","caller":"traceutil/trace.go:171","msg":"trace[707190096] transaction","detail":"{read_only:false; response_revision:17396; number_of_response:1; }","duration":"177.204895ms","start":"2026-07-21T21:30:38.865435Z","end":"2026-07-21T21:30:39.04264Z","steps":["trace[707190096] 'process raft request' (duration: 176.664684ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:31:52.913822Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15649} {"level":"info","ts":"2026-07-21T21:31:53.010278Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15649,"took":"92.825634ms","hash":663132215,"current-db-size-bytes":59244544,"current-db-size":"59 MB","current-db-size-in-use-bytes":33873920,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-07-21T21:31:53.010355Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":663132215,"revision":15649,"compact-revision":13097} {"level":"info","ts":"2026-07-21T21:34:31.207529Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"aab6040abcf11","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-07-21T21:34:31.212383Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-07-21T21:34:31.212525Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-07-21T21:35:07.246736Z","caller":"traceutil/trace.go:171","msg":"trace[1640740118] transaction","detail":"{read_only:false; response_revision:19564; number_of_response:1; }","duration":"120.641528ms","start":"2026-07-21T21:35:07.12605Z","end":"2026-07-21T21:35:07.246691Z","steps":["trace[1640740118] 'process raft request' (duration: 114.253057ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:35:09.654116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.155665ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-21T21:35:09.654316Z","caller":"traceutil/trace.go:171","msg":"trace[1275074968] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:19576; }","duration":"115.3818ms","start":"2026-07-21T21:35:09.538903Z","end":"2026-07-21T21:35:09.654284Z","steps":["trace[1275074968] 'range keys from in-memory index tree' (duration: 115.010753ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:35:09.758895Z","caller":"traceutil/trace.go:171","msg":"trace[308584225] transaction","detail":"{read_only:false; response_revision:19577; number_of_response:1; }","duration":"139.039173ms","start":"2026-07-21T21:35:09.619825Z","end":"2026-07-21T21:35:09.758864Z","steps":["trace[308584225] 'process raft request' (duration: 138.832879ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:35:09.835188Z","caller":"traceutil/trace.go:171","msg":"trace[1484133504] transaction","detail":"{read_only:false; response_revision:19578; number_of_response:1; }","duration":"214.638881ms","start":"2026-07-21T21:35:09.620524Z","end":"2026-07-21T21:35:09.835163Z","steps":["trace[1484133504] 'process raft request' (duration: 214.479568ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:35:09.975412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.034867ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-07-21T21:35:09.975475Z","caller":"traceutil/trace.go:171","msg":"trace[477358434] range","detail":"{range_begin:/registry/endpointslices/; range_end:/registry/endpointslices0; response_count:0; response_revision:19578; }","duration":"102.15659ms","start":"2026-07-21T21:35:09.873306Z","end":"2026-07-21T21:35:09.975462Z","steps":["trace[477358434] 'count revisions from in-memory index tree' (duration: 101.888355ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:35:10.31921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.505101ms","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-07-21T21:35:10.319301Z","caller":"traceutil/trace.go:171","msg":"trace[1015990911] range","detail":"{range_begin:/registry/acme.cert-manager.io/challenges/; range_end:/registry/acme.cert-manager.io/challenges0; response_count:0; response_revision:19579; }","duration":"113.679745ms","start":"2026-07-21T21:35:10.205601Z","end":"2026-07-21T21:35:10.31928Z","steps":["trace[1015990911] 'count revisions from in-memory index tree' (duration: 113.344209ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:35:10.453275Z","caller":"traceutil/trace.go:171","msg":"trace[233147761] transaction","detail":"{read_only:false; response_revision:19580; number_of_response:1; }","duration":"129.660962ms","start":"2026-07-21T21:35:10.323587Z","end":"2026-07-21T21:35:10.453248Z","steps":["trace[233147761] 'process raft request' (duration: 129.487569ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:36:52.921105Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":18195} {"level":"info","ts":"2026-07-21T21:36:53.032386Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":18195,"took":"107.701593ms","hash":2460029765,"current-db-size-bytes":59244544,"current-db-size":"59 MB","current-db-size-in-use-bytes":30740480,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-07-21T21:36:53.03246Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2460029765,"revision":18195,"compact-revision":15649} {"level":"info","ts":"2026-07-21T21:38:54.952952Z","caller":"traceutil/trace.go:171","msg":"trace[1331967035] linearizableReadLoop","detail":"{readStateIndex:22655; appliedIndex:22654; }","duration":"174.932017ms","start":"2026-07-21T21:38:54.777988Z","end":"2026-07-21T21:38:54.95292Z","steps":["trace[1331967035] 'read index received' (duration: 152.522199ms)","trace[1331967035] 'applied index is now lower than readState.Index' (duration: 22.407178ms)"],"step_count":2} {"level":"warn","ts":"2026-07-21T21:38:54.953102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.098481ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/scrapeconfigs/\" range_end:\"/registry/monitoring.coreos.com/scrapeconfigs0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-21T21:38:54.953129Z","caller":"traceutil/trace.go:171","msg":"trace[478686782] range","detail":"{range_begin:/registry/monitoring.coreos.com/scrapeconfigs/; range_end:/registry/monitoring.coreos.com/scrapeconfigs0; response_count:0; response_revision:21930; }","duration":"175.139431ms","start":"2026-07-21T21:38:54.777981Z","end":"2026-07-21T21:38:54.95312Z","steps":["trace[478686782] 'agreement among raft nodes before linearized reading' (duration: 175.04788ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:38:54.953439Z","caller":"traceutil/trace.go:171","msg":"trace[1616922114] transaction","detail":"{read_only:false; response_revision:21930; number_of_response:1; }","duration":"264.394167ms","start":"2026-07-21T21:38:54.689036Z","end":"2026-07-21T21:38:54.95343Z","steps":["trace[1616922114] 'process raft request' (duration: 241.449407ms)","trace[1616922114] 'compare' (duration: 22.01143ms)"],"step_count":2} {"level":"info","ts":"2026-07-21T21:41:52.92708Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":20458} {"level":"info","ts":"2026-07-21T21:41:53.037491Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":20458,"took":"107.394365ms","hash":2718483312,"current-db-size-bytes":59244544,"current-db-size":"59 MB","current-db-size-in-use-bytes":44617728,"current-db-size-in-use":"45 MB"} {"level":"info","ts":"2026-07-21T21:41:53.03756Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2718483312,"revision":20458,"compact-revision":18195} {"level":"info","ts":"2026-07-21T21:42:27.037715Z","caller":"traceutil/trace.go:171","msg":"trace[1446085926] linearizableReadLoop","detail":"{readStateIndex:24859; appliedIndex:24858; }","duration":"217.04101ms","start":"2026-07-21T21:42:26.820649Z","end":"2026-07-21T21:42:27.03769Z","steps":["trace[1446085926] 'read index received' (duration: 216.910397ms)","trace[1446085926] 'applied index is now lower than readState.Index' (duration: 129.663µs)"],"step_count":2} {"level":"info","ts":"2026-07-21T21:42:27.037996Z","caller":"traceutil/trace.go:171","msg":"trace[584399535] transaction","detail":"{read_only:false; response_revision:24076; number_of_response:1; }","duration":"238.237573ms","start":"2026-07-21T21:42:26.79975Z","end":"2026-07-21T21:42:27.037987Z","steps":["trace[584399535] 'process raft request' (duration: 237.802824ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:42:27.038257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.587301ms","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-07-21T21:42:27.038304Z","caller":"traceutil/trace.go:171","msg":"trace[684511011] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24076; }","duration":"217.648692ms","start":"2026-07-21T21:42:26.820643Z","end":"2026-07-21T21:42:27.038292Z","steps":["trace[684511011] 'agreement among raft nodes before linearized reading' (duration: 217.508029ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:42:27.286208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.991193ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-21T21:42:27.286336Z","caller":"traceutil/trace.go:171","msg":"trace[1121689036] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:24076; }","duration":"131.129326ms","start":"2026-07-21T21:42:27.155191Z","end":"2026-07-21T21:42:27.28632Z","steps":["trace[1121689036] 'range keys from in-memory index tree' (duration: 130.975623ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:42:27.286378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.611186ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-21T21:42:27.286786Z","caller":"traceutil/trace.go:171","msg":"trace[1160300099] transaction","detail":"{read_only:false; response_revision:24077; number_of_response:1; }","duration":"243.491659ms","start":"2026-07-21T21:42:27.042933Z","end":"2026-07-21T21:42:27.286425Z","steps":["trace[1160300099] 'process raft request' (duration: 135.781431ms)","trace[1160300099] 'compare' (duration: 107.390082ms)"],"step_count":2} {"level":"info","ts":"2026-07-21T21:42:27.298786Z","caller":"traceutil/trace.go:171","msg":"trace[1607362037] linearizableReadLoop","detail":"{readStateIndex:24862; appliedIndex:24859; }","duration":"134.285701ms","start":"2026-07-21T21:42:27.164491Z","end":"2026-07-21T21:42:27.298777Z","steps":["trace[1607362037] 'read index received' (duration: 14.189081ms)","trace[1607362037] 'applied index is now lower than readState.Index' (duration: 120.09591ms)"],"step_count":2} {"level":"info","ts":"2026-07-21T21:42:27.298937Z","caller":"traceutil/trace.go:171","msg":"trace[486285501] transaction","detail":"{read_only:false; response_revision:24078; number_of_response:1; }","duration":"251.761928ms","start":"2026-07-21T21:42:27.047168Z","end":"2026-07-21T21:42:27.29893Z","steps":["trace[486285501] 'process raft request' (duration: 251.516523ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:42:27.299032Z","caller":"traceutil/trace.go:171","msg":"trace[1928639979] transaction","detail":"{read_only:false; response_revision:24079; number_of_response:1; }","duration":"250.37146ms","start":"2026-07-21T21:42:27.048653Z","end":"2026-07-21T21:42:27.299025Z","steps":["trace[1928639979] 'process raft request' (duration: 250.099145ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:42:27.299141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.646859ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/alertmanagers/\" range_end:\"/registry/monitoring.coreos.com/alertmanagers0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-07-21T21:42:27.299169Z","caller":"traceutil/trace.go:171","msg":"trace[1830278038] range","detail":"{range_begin:/registry/monitoring.coreos.com/alertmanagers/; range_end:/registry/monitoring.coreos.com/alertmanagers0; response_count:0; response_revision:24079; }","duration":"134.708821ms","start":"2026-07-21T21:42:27.164452Z","end":"2026-07-21T21:42:27.299161Z","steps":["trace[1830278038] 'agreement among raft nodes before linearized reading' (duration: 134.66338ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:42:27.457375Z","caller":"traceutil/trace.go:171","msg":"trace[151311453] linearizableReadLoop","detail":"{readStateIndex:24863; appliedIndex:24862; }","duration":"158.534876ms","start":"2026-07-21T21:42:27.298814Z","end":"2026-07-21T21:42:27.457349Z","steps":["trace[151311453] 'read index received' (duration: 150.446231ms)","trace[151311453] 'applied index is now lower than readState.Index' (duration: 8.087955ms)"],"step_count":2} {"level":"info","ts":"2026-07-21T21:42:27.457606Z","caller":"traceutil/trace.go:171","msg":"trace[73225225] transaction","detail":"{read_only:false; response_revision:24080; number_of_response:1; }","duration":"250.855379ms","start":"2026-07-21T21:42:27.206739Z","end":"2026-07-21T21:42:27.457594Z","steps":["trace[73225225] 'process raft request' (duration: 242.504219ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:42:27.457695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.133312ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackservers/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackservers0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-21T21:42:27.457772Z","caller":"traceutil/trace.go:171","msg":"trace[400271484] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackservers/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackservers0; response_count:0; response_revision:24080; }","duration":"218.263615ms","start":"2026-07-21T21:42:27.239493Z","end":"2026-07-21T21:42:27.457756Z","steps":["trace[400271484] 'agreement among raft nodes before linearized reading' (duration: 218.115892ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:42:27.457783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.562995ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/glance-api\" ","response":"range_response_count:1 size:11837"} {"level":"info","ts":"2026-07-21T21:42:27.457844Z","caller":"traceutil/trace.go:171","msg":"trace[1465725101] range","detail":"{range_begin:/registry/deployments/openstack/glance-api; range_end:; response_count:1; response_revision:24080; }","duration":"278.653726ms","start":"2026-07-21T21:42:27.179176Z","end":"2026-07-21T21:42:27.45783Z","steps":["trace[1465725101] 'agreement among raft nodes before linearized reading' (duration: 278.417531ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:42:27.526511Z","caller":"traceutil/trace.go:171","msg":"trace[758261493] transaction","detail":"{read_only:false; response_revision:24081; number_of_response:1; }","duration":"201.710087ms","start":"2026-07-21T21:42:27.324756Z","end":"2026-07-21T21:42:27.526466Z","steps":["trace[758261493] 'process raft request' (duration: 201.450491ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:42:27.526548Z","caller":"traceutil/trace.go:171","msg":"trace[1897251581] transaction","detail":"{read_only:false; response_revision:24082; number_of_response:1; }","duration":"153.862231ms","start":"2026-07-21T21:42:27.372653Z","end":"2026-07-21T21:42:27.526515Z","steps":["trace[1897251581] 'process raft request' (duration: 153.721658ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:42:27.526576Z","caller":"traceutil/trace.go:171","msg":"trace[502523846] transaction","detail":"{read_only:false; response_revision:24083; number_of_response:1; }","duration":"153.272548ms","start":"2026-07-21T21:42:27.373271Z","end":"2026-07-21T21:42:27.526544Z","steps":["trace[502523846] 'process raft request' (duration: 153.158566ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:42:27.526851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.463071ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-barbican-server-0\" ","response":"range_response_count:1 size:1866"} {"level":"info","ts":"2026-07-21T21:42:27.526979Z","caller":"traceutil/trace.go:171","msg":"trace[1774733560] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-barbican-server-0; range_end:; response_count:1; response_revision:24083; }","duration":"124.633515ms","start":"2026-07-21T21:42:27.402328Z","end":"2026-07-21T21:42:27.526962Z","steps":["trace[1774733560] 'agreement among raft nodes before linearized reading' (duration: 124.350009ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:42:27.716669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.580103ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-21T21:42:27.716778Z","caller":"traceutil/trace.go:171","msg":"trace[224899685] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:24083; }","duration":"124.739106ms","start":"2026-07-21T21:42:27.59202Z","end":"2026-07-21T21:42:27.716759Z","steps":["trace[224899685] 'range keys from in-memory index tree' (duration: 124.487721ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:42:27.942003Z","caller":"traceutil/trace.go:171","msg":"trace[1048885113] linearizableReadLoop","detail":"{readStateIndex:24869; appliedIndex:24868; }","duration":"143.719202ms","start":"2026-07-21T21:42:27.798248Z","end":"2026-07-21T21:42:27.941967Z","steps":["trace[1048885113] 'read index received' (duration: 140.17191ms)","trace[1048885113] 'applied index is now lower than readState.Index' (duration: 3.545362ms)"],"step_count":2} {"level":"info","ts":"2026-07-21T21:42:27.942038Z","caller":"traceutil/trace.go:171","msg":"trace[930240382] transaction","detail":"{read_only:false; response_revision:24086; number_of_response:1; }","duration":"173.878778ms","start":"2026-07-21T21:42:27.768131Z","end":"2026-07-21T21:42:27.94201Z","steps":["trace[930240382] 'process raft request' (duration: 170.227964ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:42:27.942283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.014029ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:18434"} {"level":"info","ts":"2026-07-21T21:42:27.942349Z","caller":"traceutil/trace.go:171","msg":"trace[1560954888] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:24086; }","duration":"144.121021ms","start":"2026-07-21T21:42:27.798213Z","end":"2026-07-21T21:42:27.942334Z","steps":["trace[1560954888] 'agreement among raft nodes before linearized reading' (duration: 143.879076ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:42:28.76819Z","caller":"traceutil/trace.go:171","msg":"trace[567160520] linearizableReadLoop","detail":"{readStateIndex:24870; appliedIndex:24869; }","duration":"257.996066ms","start":"2026-07-21T21:42:28.51017Z","end":"2026-07-21T21:42:28.768167Z","steps":["trace[567160520] 'read index received' (duration: 257.816742ms)","trace[567160520] 'applied index is now lower than readState.Index' (duration: 178.654µs)"],"step_count":2} {"level":"warn","ts":"2026-07-21T21:42:28.768577Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.32694ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-21T21:42:28.76866Z","caller":"traceutil/trace.go:171","msg":"trace[1647273072] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24087; }","duration":"230.453913ms","start":"2026-07-21T21:42:28.538186Z","end":"2026-07-21T21:42:28.76864Z","steps":["trace[1647273072] 'agreement among raft nodes before linearized reading' (duration: 230.30578ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:42:28.768645Z","caller":"traceutil/trace.go:171","msg":"trace[1448290489] transaction","detail":"{read_only:false; response_revision:24087; number_of_response:1; }","duration":"289.821344ms","start":"2026-07-21T21:42:28.478768Z","end":"2026-07-21T21:42:28.76859Z","steps":["trace[1448290489] 'process raft request' (duration: 289.274263ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:42:28.768776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.585017ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-21T21:42:28.768819Z","caller":"traceutil/trace.go:171","msg":"trace[371265297] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0; response_count:0; response_revision:24087; }","duration":"258.69102ms","start":"2026-07-21T21:42:28.510117Z","end":"2026-07-21T21:42:28.768808Z","steps":["trace[371265297] 'agreement among raft nodes before linearized reading' (duration: 258.605088ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:42:28.768996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.139041ms","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-07-21T21:42:28.769018Z","caller":"traceutil/trace.go:171","msg":"trace[2099567219] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24087; }","duration":"216.239913ms","start":"2026-07-21T21:42:28.552773Z","end":"2026-07-21T21:42:28.769013Z","steps":["trace[2099567219] 'agreement among raft nodes before linearized reading' (duration: 216.175161ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:42:28.98472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.534183ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-21T21:42:28.985035Z","caller":"traceutil/trace.go:171","msg":"trace[1930877426] linearizableReadLoop","detail":"{readStateIndex:24873; appliedIndex:24870; }","duration":"207.095266ms","start":"2026-07-21T21:42:28.777917Z","end":"2026-07-21T21:42:28.985013Z","steps":["trace[1930877426] 'read index received' (duration: 77.172935ms)","trace[1930877426] 'applied index is now lower than readState.Index' (duration: 129.921311ms)"],"step_count":2} {"level":"info","ts":"2026-07-21T21:42:28.985136Z","caller":"traceutil/trace.go:171","msg":"trace[1243798822] transaction","detail":"{read_only:false; response_revision:24089; number_of_response:1; }","duration":"211.070508ms","start":"2026-07-21T21:42:28.774054Z","end":"2026-07-21T21:42:28.985124Z","steps":["trace[1243798822] 'process raft request' (duration: 210.790282ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:42:28.985369Z","caller":"traceutil/trace.go:171","msg":"trace[2113280233] transaction","detail":"{read_only:false; response_revision:24088; number_of_response:1; }","duration":"211.269662ms","start":"2026-07-21T21:42:28.774055Z","end":"2026-07-21T21:42:28.985325Z","steps":["trace[2113280233] 'process raft request' (duration: 81.022264ms)","trace[2113280233] 'compare' (duration: 129.226707ms)"],"step_count":2} {"level":"info","ts":"2026-07-21T21:42:28.985493Z","caller":"traceutil/trace.go:171","msg":"trace[116167677] transaction","detail":"{read_only:false; response_revision:24090; number_of_response:1; }","duration":"211.366094ms","start":"2026-07-21T21:42:28.774109Z","end":"2026-07-21T21:42:28.985475Z","steps":["trace[116167677] 'process raft request' (duration: 210.856613ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:42:28.985425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.18935ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/domains/\" range_end:\"/registry/openstack.k-orc.cloud/domains0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-21T21:42:28.98559Z","caller":"traceutil/trace.go:171","msg":"trace[1531176798] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/domains/; range_end:/registry/openstack.k-orc.cloud/domains0; response_count:0; response_revision:24090; }","duration":"163.413226ms","start":"2026-07-21T21:42:28.822138Z","end":"2026-07-21T21:42:28.985551Z","steps":["trace[1531176798] 'agreement among raft nodes before linearized reading' (duration: 163.196091ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:42:28.985618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.667679ms","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-07-21T21:42:28.985745Z","caller":"traceutil/trace.go:171","msg":"trace[98242922] range","detail":"{range_begin:/registry/services/specs/magnum-system/; range_end:/registry/services/specs/magnum-system0; response_count:0; response_revision:24090; }","duration":"207.821382ms","start":"2026-07-21T21:42:28.777888Z","end":"2026-07-21T21:42:28.985709Z","steps":["trace[98242922] 'agreement among raft nodes before linearized reading' (duration: 207.632938ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:42:29.593908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.998555ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-21T21:42:29.593995Z","caller":"traceutil/trace.go:171","msg":"trace[324221004] transaction","detail":"{read_only:false; response_revision:24092; number_of_response:1; }","duration":"284.247153ms","start":"2026-07-21T21:42:29.309732Z","end":"2026-07-21T21:42:29.593979Z","steps":["trace[324221004] 'process raft request' (duration: 129.107736ms)","trace[324221004] 'compare' (duration: 154.912312ms)"],"step_count":2} {"level":"info","ts":"2026-07-21T21:42:29.607554Z","caller":"traceutil/trace.go:171","msg":"trace[205178275] linearizableReadLoop","detail":"{readStateIndex:24876; appliedIndex:24875; }","duration":"156.79922ms","start":"2026-07-21T21:42:29.450726Z","end":"2026-07-21T21:42:29.607525Z","steps":["trace[205178275] 'read index received' (duration: 156.728299ms)","trace[205178275] 'applied index is now lower than readState.Index' (duration: 69.941µs)"],"step_count":2} {"level":"info","ts":"2026-07-21T21:42:29.607698Z","caller":"traceutil/trace.go:171","msg":"trace[1088611586] transaction","detail":"{read_only:false; response_revision:24093; number_of_response:1; }","duration":"296.39915ms","start":"2026-07-21T21:42:29.311265Z","end":"2026-07-21T21:42:29.607664Z","steps":["trace[1088611586] 'process raft request' (duration: 296.129194ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:42:29.607781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.042205ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:533"} {"level":"info","ts":"2026-07-21T21:42:29.607818Z","caller":"traceutil/trace.go:171","msg":"trace[2069023793] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:24093; }","duration":"157.096896ms","start":"2026-07-21T21:42:29.450709Z","end":"2026-07-21T21:42:29.607806Z","steps":["trace[2069023793] 'agreement among raft nodes before linearized reading' (duration: 156.928532ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:42:29.619374Z","caller":"traceutil/trace.go:171","msg":"trace[2072609248] transaction","detail":"{read_only:false; response_revision:24094; number_of_response:1; }","duration":"156.905292ms","start":"2026-07-21T21:42:29.462434Z","end":"2026-07-21T21:42:29.619339Z","steps":["trace[2072609248] 'process raft request' (duration: 156.703088ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:42:29.743466Z","caller":"traceutil/trace.go:171","msg":"trace[1681317991] transaction","detail":"{read_only:false; response_revision:24098; number_of_response:1; }","duration":"131.424902ms","start":"2026-07-21T21:42:29.612002Z","end":"2026-07-21T21:42:29.743427Z","steps":["trace[1681317991] 'process raft request' (duration: 131.027934ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:42:30.017096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.777181ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-21T21:42:30.017328Z","caller":"traceutil/trace.go:171","msg":"trace[1492214672] transaction","detail":"{read_only:false; response_revision:24099; number_of_response:1; }","duration":"254.043595ms","start":"2026-07-21T21:42:29.763253Z","end":"2026-07-21T21:42:30.017297Z","steps":["trace[1492214672] 'process raft request' (duration: 119.002579ms)","trace[1492214672] 'compare' (duration: 134.574867ms)"],"step_count":2} {"level":"info","ts":"2026-07-21T21:42:31.151263Z","caller":"traceutil/trace.go:171","msg":"trace[1636121876] transaction","detail":"{read_only:false; response_revision:24103; number_of_response:1; }","duration":"153.85487ms","start":"2026-07-21T21:42:30.997377Z","end":"2026-07-21T21:42:31.151231Z","steps":["trace[1636121876] 'process raft request' (duration: 153.316579ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:42:31.186888Z","caller":"traceutil/trace.go:171","msg":"trace[453487753] linearizableReadLoop","detail":"{readStateIndex:24888; appliedIndex:24885; }","duration":"139.574189ms","start":"2026-07-21T21:42:31.047283Z","end":"2026-07-21T21:42:31.186857Z","steps":["trace[453487753] 'read index received' (duration: 103.650195ms)","trace[453487753] 'applied index is now lower than readState.Index' (duration: 35.922884ms)"],"step_count":2} {"level":"info","ts":"2026-07-21T21:42:31.186923Z","caller":"traceutil/trace.go:171","msg":"trace[841427838] transaction","detail":"{read_only:false; response_revision:24104; number_of_response:1; }","duration":"189.220041ms","start":"2026-07-21T21:42:30.997668Z","end":"2026-07-21T21:42:31.186888Z","steps":["trace[841427838] 'process raft request' (duration: 188.967746ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:42:31.187082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.767372ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/roles/\" range_end:\"/registry/openstack.k-orc.cloud/roles0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-21T21:42:31.18714Z","caller":"traceutil/trace.go:171","msg":"trace[2011400083] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/roles/; range_end:/registry/openstack.k-orc.cloud/roles0; response_count:0; response_revision:24105; }","duration":"139.855084ms","start":"2026-07-21T21:42:31.047266Z","end":"2026-07-21T21:42:31.187121Z","steps":["trace[2011400083] 'agreement among raft nodes before linearized reading' (duration: 139.708341ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:42:31.187312Z","caller":"traceutil/trace.go:171","msg":"trace[320597698] transaction","detail":"{read_only:false; response_revision:24105; number_of_response:1; }","duration":"188.902285ms","start":"2026-07-21T21:42:30.998397Z","end":"2026-07-21T21:42:31.187299Z","steps":["trace[320597698] 'process raft request' (duration: 188.416515ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:42:31.640373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.852676ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-21T21:42:31.640489Z","caller":"traceutil/trace.go:171","msg":"trace[959108596] linearizableReadLoop","detail":"{readStateIndex:24891; appliedIndex:24889; }","duration":"238.815284ms","start":"2026-07-21T21:42:31.401651Z","end":"2026-07-21T21:42:31.640467Z","steps":["trace[959108596] 'read index received' (duration: 9.472033ms)","trace[959108596] 'applied index is now lower than readState.Index' (duration: 229.341491ms)"],"step_count":2} {"level":"info","ts":"2026-07-21T21:42:31.640525Z","caller":"traceutil/trace.go:171","msg":"trace[1942849121] transaction","detail":"{read_only:false; response_revision:24107; number_of_response:1; }","duration":"252.592985ms","start":"2026-07-21T21:42:31.387891Z","end":"2026-07-21T21:42:31.640484Z","steps":["trace[1942849121] 'process raft request' (duration: 130.538025ms)","trace[1942849121] 'compare' (duration: 121.674223ms)"],"step_count":2} {"level":"warn","ts":"2026-07-21T21:42:31.640672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.008117ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/prometheusagents/\" range_end:\"/registry/monitoring.coreos.com/prometheusagents0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-21T21:42:31.640777Z","caller":"traceutil/trace.go:171","msg":"trace[1509400737] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheusagents/; range_end:/registry/monitoring.coreos.com/prometheusagents0; response_count:0; response_revision:24107; }","duration":"239.12873ms","start":"2026-07-21T21:42:31.401625Z","end":"2026-07-21T21:42:31.640753Z","steps":["trace[1509400737] 'agreement among raft nodes before linearized reading' (duration: 238.930466ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:42:31.919132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.784537ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-21T21:42:31.919524Z","caller":"traceutil/trace.go:171","msg":"trace[128345746] transaction","detail":"{read_only:false; response_revision:24109; number_of_response:1; }","duration":"294.994601ms","start":"2026-07-21T21:42:31.624421Z","end":"2026-07-21T21:42:31.919416Z","steps":["trace[128345746] 'process raft request' (duration: 294.850658ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:42:31.919565Z","caller":"traceutil/trace.go:171","msg":"trace[300615718] transaction","detail":"{read_only:false; response_revision:24108; number_of_response:1; }","duration":"398.33979ms","start":"2026-07-21T21:42:31.521185Z","end":"2026-07-21T21:42:31.919525Z","steps":["trace[300615718] 'process raft request' (duration: 250.057493ms)","trace[300615718] 'compare' (duration: 147.636444ms)"],"step_count":2} {"level":"warn","ts":"2026-07-21T21:42:31.919749Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T21:42:31.521162Z","time spent":"398.492313ms","remote":"127.0.0.1:37486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":627,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-21T21:42:31.919847Z","caller":"traceutil/trace.go:171","msg":"trace[791605863] transaction","detail":"{read_only:false; response_revision:24110; number_of_response:1; }","duration":"294.102493ms","start":"2026-07-21T21:42:31.625712Z","end":"2026-07-21T21:42:31.919814Z","steps":["trace[791605863] 'process raft request' (duration: 293.653054ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:42:31.919882Z","caller":"traceutil/trace.go:171","msg":"trace[1669542603] transaction","detail":"{read_only:false; response_revision:24112; number_of_response:1; }","duration":"294.086463ms","start":"2026-07-21T21:42:31.625778Z","end":"2026-07-21T21:42:31.919864Z","steps":["trace[1669542603] 'process raft request' (duration: 294.040722ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:42:31.919876Z","caller":"traceutil/trace.go:171","msg":"trace[814759322] linearizableReadLoop","detail":"{readStateIndex:24896; appliedIndex:24891; }","duration":"279.325621ms","start":"2026-07-21T21:42:31.640529Z","end":"2026-07-21T21:42:31.919855Z","steps":["trace[814759322] 'read index received' (duration: 130.726339ms)","trace[814759322] 'applied index is now lower than readState.Index' (duration: 148.598692ms)"],"step_count":2} {"level":"info","ts":"2026-07-21T21:42:31.919892Z","caller":"traceutil/trace.go:171","msg":"trace[1765454445] transaction","detail":"{read_only:false; response_revision:24111; number_of_response:1; }","duration":"294.104433ms","start":"2026-07-21T21:42:31.625762Z","end":"2026-07-21T21:42:31.919866Z","steps":["trace[1765454445] 'process raft request' (duration: 293.9665ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:42:31.920031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.232567ms","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-07-21T21:42:31.920053Z","caller":"traceutil/trace.go:171","msg":"trace[190778938] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24112; }","duration":"322.305588ms","start":"2026-07-21T21:42:31.59774Z","end":"2026-07-21T21:42:31.920046Z","steps":["trace[190778938] 'agreement among raft nodes before linearized reading' (duration: 322.192196ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:42:31.920083Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T21:42:31.59772Z","time spent":"322.355749ms","remote":"127.0.0.1:37486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-21T21:42:31.920061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.440355ms","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-07-21T21:42:31.920149Z","caller":"traceutil/trace.go:171","msg":"trace[593528823] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24112; }","duration":"309.548347ms","start":"2026-07-21T21:42:31.610575Z","end":"2026-07-21T21:42:31.920123Z","steps":["trace[593528823] 'agreement among raft nodes before linearized reading' (duration: 309.344773ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:42:31.920199Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T21:42:31.610566Z","time spent":"309.624269ms","remote":"127.0.0.1:37486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-21T21:42:32.213809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.744867ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-21T21:42:32.213959Z","caller":"traceutil/trace.go:171","msg":"trace[1705940406] transaction","detail":"{read_only:false; response_revision:24113; number_of_response:1; }","duration":"289.748914ms","start":"2026-07-21T21:42:31.924186Z","end":"2026-07-21T21:42:32.213935Z","steps":["trace[1705940406] 'process raft request' (duration: 139.748702ms)","trace[1705940406] 'compare' (duration: 147.845257ms)"],"step_count":2} {"level":"info","ts":"2026-07-21T21:42:32.385414Z","caller":"traceutil/trace.go:171","msg":"trace[612802117] transaction","detail":"{read_only:false; response_revision:24114; number_of_response:1; }","duration":"460.978467ms","start":"2026-07-21T21:42:31.924405Z","end":"2026-07-21T21:42:32.385383Z","steps":["trace[612802117] 'process raft request' (duration: 435.060889ms)","trace[612802117] 'compare' (duration: 25.719564ms)"],"step_count":2} {"level":"info","ts":"2026-07-21T21:42:32.385767Z","caller":"traceutil/trace.go:171","msg":"trace[541260018] linearizableReadLoop","detail":"{readStateIndex:24898; appliedIndex:24896; }","duration":"428.662009ms","start":"2026-07-21T21:42:31.957047Z","end":"2026-07-21T21:42:32.385709Z","steps":["trace[541260018] 'read index received' (duration: 106.902372ms)","trace[541260018] 'applied index is now lower than readState.Index' (duration: 321.758287ms)"],"step_count":2} {"level":"info","ts":"2026-07-21T21:42:32.385929Z","caller":"traceutil/trace.go:171","msg":"trace[2018693617] transaction","detail":"{read_only:false; response_revision:24115; number_of_response:1; }","duration":"363.268424ms","start":"2026-07-21T21:42:32.02264Z","end":"2026-07-21T21:42:32.385909Z","steps":["trace[2018693617] 'process raft request' (duration: 362.677782ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:42:32.386021Z","caller":"traceutil/trace.go:171","msg":"trace[1844710512] transaction","detail":"{read_only:false; response_revision:24116; number_of_response:1; }","duration":"362.654832ms","start":"2026-07-21T21:42:32.023335Z","end":"2026-07-21T21:42:32.38599Z","steps":["trace[1844710512] 'process raft request' (duration: 362.230503ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:42:32.386115Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T21:42:32.022619Z","time spent":"363.411436ms","remote":"127.0.0.1:37486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-21T21:42:32.386123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"429.056727ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.carvel.dev/secrettemplates/\" range_end:\"/registry/secretgen.carvel.dev/secrettemplates0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-07-21T21:42:32.386202Z","caller":"traceutil/trace.go:171","msg":"trace[1112843931] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secrettemplates/; range_end:/registry/secretgen.carvel.dev/secrettemplates0; response_count:0; response_revision:24116; }","duration":"429.1926ms","start":"2026-07-21T21:42:31.956993Z","end":"2026-07-21T21:42:32.386186Z","steps":["trace[1112843931] 'agreement among raft nodes before linearized reading' (duration: 429.046737ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:42:32.386237Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T21:42:31.956975Z","time spent":"429.25374ms","remote":"127.0.0.1:59348","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":2,"response size":29,"request content":"key:\"/registry/secretgen.carvel.dev/secrettemplates/\" range_end:\"/registry/secretgen.carvel.dev/secrettemplates0\" count_only:true "} {"level":"warn","ts":"2026-07-21T21:42:32.386282Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T21:42:31.924384Z","time spent":"461.110141ms","remote":"127.0.0.1:37486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-21T21:42:32.386676Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T21:42:32.023319Z","time spent":"362.776034ms","remote":"127.0.0.1:37486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-21T21:42:32.923921Z","caller":"traceutil/trace.go:171","msg":"trace[1212889258] transaction","detail":"{read_only:false; response_revision:24117; number_of_response:1; }","duration":"134.614197ms","start":"2026-07-21T21:42:32.789276Z","end":"2026-07-21T21:42:32.92389Z","steps":["trace[1212889258] 'process raft request' (duration: 134.400783ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:42:33.19953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.458877ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-07-21T21:42:33.199609Z","caller":"traceutil/trace.go:171","msg":"trace[1752405311] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:24117; }","duration":"238.591369ms","start":"2026-07-21T21:42:32.961001Z","end":"2026-07-21T21:42:33.199592Z","steps":["trace[1752405311] 'range keys from in-memory index tree' (duration: 238.312444ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:42:33.199651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.964822ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-21T21:42:33.199756Z","caller":"traceutil/trace.go:171","msg":"trace[262991900] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:24117; }","duration":"180.149856ms","start":"2026-07-21T21:42:33.019582Z","end":"2026-07-21T21:42:33.199732Z","steps":["trace[262991900] 'count revisions from in-memory index tree' (duration: 179.83155ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:42:33.405242Z","caller":"traceutil/trace.go:171","msg":"trace[2133604581] linearizableReadLoop","detail":"{readStateIndex:24903; appliedIndex:24901; }","duration":"201.062354ms","start":"2026-07-21T21:42:33.204151Z","end":"2026-07-21T21:42:33.405213Z","steps":["trace[2133604581] 'read index received' (duration: 15.015607ms)","trace[2133604581] 'applied index is now lower than readState.Index' (duration: 186.045557ms)"],"step_count":2} {"level":"warn","ts":"2026-07-21T21:42:33.405483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.307378ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:18434"} {"level":"info","ts":"2026-07-21T21:42:33.405511Z","caller":"traceutil/trace.go:171","msg":"trace[980642996] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:24120; }","duration":"201.355139ms","start":"2026-07-21T21:42:33.204146Z","end":"2026-07-21T21:42:33.405501Z","steps":["trace[980642996] 'agreement among raft nodes before linearized reading' (duration: 201.177306ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:42:33.405765Z","caller":"traceutil/trace.go:171","msg":"trace[276435019] transaction","detail":"{read_only:false; response_revision:24120; number_of_response:1; }","duration":"201.572964ms","start":"2026-07-21T21:42:33.204181Z","end":"2026-07-21T21:42:33.405754Z","steps":["trace[276435019] 'process raft request' (duration: 200.990963ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:42:33.40578Z","caller":"traceutil/trace.go:171","msg":"trace[77554755] transaction","detail":"{read_only:false; response_revision:24119; number_of_response:1; }","duration":"201.90481ms","start":"2026-07-21T21:42:33.203844Z","end":"2026-07-21T21:42:33.405748Z","steps":["trace[77554755] 'process raft request' (duration: 201.131975ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:42:38.048603Z","caller":"traceutil/trace.go:171","msg":"trace[1151550685] transaction","detail":"{read_only:false; response_revision:24152; number_of_response:1; }","duration":"110.567197ms","start":"2026-07-21T21:42:37.937726Z","end":"2026-07-21T21:42:38.048294Z","steps":["trace[1151550685] 'process raft request' (duration: 110.396514ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:42:38.049275Z","caller":"traceutil/trace.go:171","msg":"trace[810890073] transaction","detail":"{read_only:false; response_revision:24153; number_of_response:1; }","duration":"108.708269ms","start":"2026-07-21T21:42:37.940531Z","end":"2026-07-21T21:42:38.049239Z","steps":["trace[810890073] 'process raft request' (duration: 108.462964ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:42:38.049595Z","caller":"traceutil/trace.go:171","msg":"trace[1842456265] transaction","detail":"{read_only:false; response_revision:24154; number_of_response:1; }","duration":"108.031725ms","start":"2026-07-21T21:42:37.941535Z","end":"2026-07-21T21:42:38.049567Z","steps":["trace[1842456265] 'process raft request' (duration: 107.643157ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:42:38.050005Z","caller":"traceutil/trace.go:171","msg":"trace[1746565525] transaction","detail":"{read_only:false; response_revision:24155; number_of_response:1; }","duration":"107.631586ms","start":"2026-07-21T21:42:37.942347Z","end":"2026-07-21T21:42:38.049978Z","steps":["trace[1746565525] 'process raft request' (duration: 107.107565ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:42:41.061929Z","caller":"traceutil/trace.go:171","msg":"trace[1180761995] transaction","detail":"{read_only:false; response_revision:24173; number_of_response:1; }","duration":"113.274822ms","start":"2026-07-21T21:42:40.94862Z","end":"2026-07-21T21:42:41.061895Z","steps":["trace[1180761995] 'process raft request' (duration: 113.083888ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:42:42.458255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"586.516521ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-07-21T21:42:42.458803Z","caller":"traceutil/trace.go:171","msg":"trace[1991758337] transaction","detail":"{read_only:false; response_revision:24174; number_of_response:1; }","duration":"1.115550838s","start":"2026-07-21T21:42:41.343228Z","end":"2026-07-21T21:42:42.458779Z","steps":["trace[1991758337] 'process raft request' (duration: 1.11514308s)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:42:42.45894Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T21:42:41.343204Z","time spent":"1.115661401s","remote":"127.0.0.1:37486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-21T21:42:42.746329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.457667ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-21T21:42:42.746532Z","caller":"traceutil/trace.go:171","msg":"trace[423520214] transaction","detail":"{read_only:false; response_revision:24175; number_of_response:1; }","duration":"1.067466356s","start":"2026-07-21T21:42:41.679035Z","end":"2026-07-21T21:42:42.746501Z","steps":["trace[423520214] 'process raft request' (duration: 779.734244ms)","trace[423520214] 'compare' (duration: 286.854284ms)"],"step_count":2} {"level":"info","ts":"2026-07-21T21:42:42.746644Z","caller":"traceutil/trace.go:171","msg":"trace[354121319] transaction","detail":"{read_only:false; response_revision:24178; number_of_response:1; }","duration":"672.946635ms","start":"2026-07-21T21:42:42.073677Z","end":"2026-07-21T21:42:42.746624Z","steps":["trace[354121319] 'process raft request' (duration: 672.882643ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:42:42.746675Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T21:42:41.679002Z","time spent":"1.067609439s","remote":"127.0.0.1:37486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-21T21:42:42.746723Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T21:42:42.073616Z","time spent":"673.073147ms","remote":"127.0.0.1:37486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":497,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-21T21:42:42.746829Z","caller":"traceutil/trace.go:171","msg":"trace[2121902284] transaction","detail":"{read_only:false; response_revision:24176; number_of_response:1; }","duration":"806.168274ms","start":"2026-07-21T21:42:41.94052Z","end":"2026-07-21T21:42:42.746689Z","steps":["trace[2121902284] 'process raft request' (duration: 805.943889ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:42:42.746928Z","caller":"traceutil/trace.go:171","msg":"trace[1070317145] transaction","detail":"{read_only:false; response_revision:24177; number_of_response:1; }","duration":"677.033128ms","start":"2026-07-21T21:42:42.06986Z","end":"2026-07-21T21:42:42.746893Z","steps":["trace[1070317145] 'process raft request' (duration: 676.665861ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:42:42.746915Z","caller":"traceutil/trace.go:171","msg":"trace[1489068870] transaction","detail":"{read_only:false; response_revision:24179; number_of_response:1; }","duration":"673.066107ms","start":"2026-07-21T21:42:42.07382Z","end":"2026-07-21T21:42:42.746886Z","steps":["trace[1489068870] 'process raft request' (duration: 672.773471ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:42:42.747035Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T21:42:42.069834Z","time spent":"677.148381ms","remote":"127.0.0.1:37486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":607,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-21T21:42:42.747166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.308153519s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"warn","ts":"2026-07-21T21:42:42.747177Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T21:42:41.940493Z","time spent":"806.51804ms","remote":"127.0.0.1:37486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":627,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-21T21:42:42.747218Z","caller":"traceutil/trace.go:171","msg":"trace[1098098456] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24180; }","duration":"1.3082502s","start":"2026-07-21T21:42:41.438956Z","end":"2026-07-21T21:42:42.747207Z","steps":["trace[1098098456] 'agreement among raft nodes before linearized reading' (duration: 1.308090737s)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:42:42.746894Z","caller":"traceutil/trace.go:171","msg":"trace[1248969695] transaction","detail":"{read_only:false; response_revision:24180; number_of_response:1; }","duration":"672.975784ms","start":"2026-07-21T21:42:42.073893Z","end":"2026-07-21T21:42:42.746868Z","steps":["trace[1248969695] 'process raft request' (duration: 672.909473ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:42:42.747262Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T21:42:41.438926Z","time spent":"1.308327712s","remote":"127.0.0.1:37486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-21T21:42:42.747291Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T21:42:42.073867Z","time spent":"673.388653ms","remote":"127.0.0.1:37486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-21T21:42:42.746753Z","caller":"traceutil/trace.go:171","msg":"trace[1417538230] linearizableReadLoop","detail":"{readStateIndex:24960; appliedIndex:24958; }","duration":"1.307574147s","start":"2026-07-21T21:42:41.43902Z","end":"2026-07-21T21:42:42.746594Z","steps":["trace[1417538230] 'read index received' (duration: 432.640569ms)","trace[1417538230] 'applied index is now lower than readState.Index' (duration: 874.929578ms)"],"step_count":2} {"level":"warn","ts":"2026-07-21T21:42:42.748161Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T21:42:42.073801Z","time spent":"674.274011ms","remote":"127.0.0.1:37486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-21T21:42:42.771203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.581868ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-21T21:42:42.771284Z","caller":"traceutil/trace.go:171","msg":"trace[863944902] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24182; }","duration":"233.705111ms","start":"2026-07-21T21:42:42.53756Z","end":"2026-07-21T21:42:42.771265Z","steps":["trace[863944902] 'agreement among raft nodes before linearized reading' (duration: 233.575788ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:42:42.771312Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"515.743247ms","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-07-21T21:42:42.771308Z","caller":"traceutil/trace.go:171","msg":"trace[910276629] transaction","detail":"{read_only:false; response_revision:24181; number_of_response:1; }","duration":"350.153286ms","start":"2026-07-21T21:42:42.421134Z","end":"2026-07-21T21:42:42.771287Z","steps":["trace[910276629] 'process raft request' (duration: 349.783568ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:42:42.771311Z","caller":"traceutil/trace.go:171","msg":"trace[2070953506] transaction","detail":"{read_only:false; response_revision:24182; number_of_response:1; }","duration":"339.572832ms","start":"2026-07-21T21:42:42.431694Z","end":"2026-07-21T21:42:42.771267Z","steps":["trace[2070953506] 'process raft request' (duration: 339.336486ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:42:42.771405Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T21:42:42.421097Z","time spent":"350.253988ms","remote":"127.0.0.1:37486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-21T21:42:42.771478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.325547595s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:559"} {"level":"warn","ts":"2026-07-21T21:42:42.771505Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T21:42:42.431669Z","time spent":"339.738355ms","remote":"127.0.0.1:37486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-21T21:42:42.771542Z","caller":"traceutil/trace.go:171","msg":"trace[1707749298] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:24182; }","duration":"1.325606896s","start":"2026-07-21T21:42:41.445916Z","end":"2026-07-21T21:42:42.771522Z","steps":["trace[1707749298] 'agreement among raft nodes before linearized reading' (duration: 1.325475783s)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:42:42.771595Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T21:42:41.445858Z","time spent":"1.325725208s","remote":"127.0.0.1:37486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":580,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"info","ts":"2026-07-21T21:42:42.771357Z","caller":"traceutil/trace.go:171","msg":"trace[584144723] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24182; }","duration":"515.815478ms","start":"2026-07-21T21:42:42.255524Z","end":"2026-07-21T21:42:42.771339Z","steps":["trace[584144723] 'agreement among raft nodes before linearized reading' (duration: 515.729686ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:42:42.77122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.327206517s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"warn","ts":"2026-07-21T21:42:42.77166Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T21:42:42.255502Z","time spent":"516.148305ms","remote":"127.0.0.1:37486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-21T21:42:42.771682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"452.318382ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" ","response":"range_response_count:1 size:1989"} {"level":"info","ts":"2026-07-21T21:42:42.771689Z","caller":"traceutil/trace.go:171","msg":"trace[1928571400] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24182; }","duration":"1.327714648s","start":"2026-07-21T21:42:41.443956Z","end":"2026-07-21T21:42:42.77167Z","steps":["trace[1928571400] 'agreement among raft nodes before linearized reading' (duration: 1.327123046s)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:42:42.771746Z","caller":"traceutil/trace.go:171","msg":"trace[2076178354] range","detail":"{range_begin:/registry/services/specs/ingress-nginx/ingress-nginx-controller; range_end:; response_count:1; response_revision:24182; }","duration":"452.782291ms","start":"2026-07-21T21:42:42.318942Z","end":"2026-07-21T21:42:42.771725Z","steps":["trace[2076178354] 'agreement among raft nodes before linearized reading' (duration: 452.266661ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:42:42.771753Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T21:42:41.443937Z","time spent":"1.327800619s","remote":"127.0.0.1:37486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-21T21:42:42.7718Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T21:42:42.318921Z","time spent":"452.865413ms","remote":"127.0.0.1:37406","response type":"/etcdserverpb.KV/Range","request count":0,"request size":65,"response count":1,"response size":2010,"request content":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" "} {"level":"warn","ts":"2026-07-21T21:42:42.771817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.359705ms","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-07-21T21:42:42.771877Z","caller":"traceutil/trace.go:171","msg":"trace[443911590] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24182; }","duration":"335.419377ms","start":"2026-07-21T21:42:42.43644Z","end":"2026-07-21T21:42:42.771859Z","steps":["trace[443911590] 'agreement among raft nodes before linearized reading' (duration: 335.248853ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:42:42.771919Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T21:42:42.436429Z","time spent":"335.479118ms","remote":"127.0.0.1:37486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-21T21:42:43.190224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.412943ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-21T21:42:43.190313Z","caller":"traceutil/trace.go:171","msg":"trace[2033194761] linearizableReadLoop","detail":"{readStateIndex:24969; appliedIndex:24968; }","duration":"417.943869ms","start":"2026-07-21T21:42:42.772355Z","end":"2026-07-21T21:42:43.190299Z","steps":["trace[2033194761] 'read index received' (duration: 259.505706ms)","trace[2033194761] 'applied index is now lower than readState.Index' (duration: 158.437043ms)"],"step_count":2} {"level":"info","ts":"2026-07-21T21:42:43.190341Z","caller":"traceutil/trace.go:171","msg":"trace[1084252794] transaction","detail":"{read_only:false; response_revision:24183; number_of_response:1; }","duration":"438.105041ms","start":"2026-07-21T21:42:42.752203Z","end":"2026-07-21T21:42:43.190308Z","steps":["trace[1084252794] 'process raft request' (duration: 279.517325ms)","trace[1084252794] 'compare' (duration: 158.088996ms)"],"step_count":2} {"level":"warn","ts":"2026-07-21T21:42:43.190391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"418.033851ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-21T21:42:43.190416Z","caller":"traceutil/trace.go:171","msg":"trace[467828037] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24183; }","duration":"418.079873ms","start":"2026-07-21T21:42:42.77233Z","end":"2026-07-21T21:42:43.19041Z","steps":["trace[467828037] 'agreement among raft nodes before linearized reading' (duration: 418.029912ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:42:43.190435Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T21:42:42.772312Z","time spent":"418.118413ms","remote":"127.0.0.1:37266","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-21T21:42:43.190471Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T21:42:42.752182Z","time spent":"438.233054ms","remote":"127.0.0.1:37486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-21T21:42:43.192809Z","caller":"traceutil/trace.go:171","msg":"trace[832659336] transaction","detail":"{read_only:false; response_revision:24184; number_of_response:1; }","duration":"417.090512ms","start":"2026-07-21T21:42:42.775698Z","end":"2026-07-21T21:42:43.192788Z","steps":["trace[832659336] 'process raft request' (duration: 416.833037ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:42:43.192794Z","caller":"traceutil/trace.go:171","msg":"trace[669649206] transaction","detail":"{read_only:false; response_revision:24185; number_of_response:1; }","duration":"416.264706ms","start":"2026-07-21T21:42:42.776501Z","end":"2026-07-21T21:42:43.192766Z","steps":["trace[669649206] 'process raft request' (duration: 416.153844ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:42:43.192977Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T21:42:42.776492Z","time spent":"416.397638ms","remote":"127.0.0.1:37486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-21T21:42:43.193073Z","caller":"traceutil/trace.go:171","msg":"trace[1569648522] transaction","detail":"{read_only:false; response_revision:24186; number_of_response:1; }","duration":"416.072721ms","start":"2026-07-21T21:42:42.776978Z","end":"2026-07-21T21:42:43.193051Z","steps":["trace[1569648522] 'process raft request' (duration: 415.749165ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:42:43.193181Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T21:42:42.776964Z","time spent":"416.160353ms","remote":"127.0.0.1:37486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-21T21:42:43.193324Z","caller":"traceutil/trace.go:171","msg":"trace[391862639] transaction","detail":"{read_only:false; response_revision:24187; number_of_response:1; }","duration":"415.900587ms","start":"2026-07-21T21:42:42.777399Z","end":"2026-07-21T21:42:43.1933Z","steps":["trace[391862639] 'process raft request' (duration: 415.609712ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:42:43.193493Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T21:42:42.77739Z","time spent":"416.04907ms","remote":"127.0.0.1:37486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-21T21:42:43.193594Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T21:42:42.775684Z","time spent":"417.201505ms","remote":"127.0.0.1:37486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-21T21:42:43.193792Z","caller":"traceutil/trace.go:171","msg":"trace[544923198] transaction","detail":"{read_only:false; response_revision:24188; number_of_response:1; }","duration":"126.645104ms","start":"2026-07-21T21:42:43.06713Z","end":"2026-07-21T21:42:43.193775Z","steps":["trace[544923198] 'process raft request' (duration: 126.418129ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:42:43.193915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"393.548942ms","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":"warn","ts":"2026-07-21T21:42:43.193936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"417.717836ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/openstack/container-infra\" ","response":"range_response_count:1 size:729"} {"level":"info","ts":"2026-07-21T21:42:43.193969Z","caller":"traceutil/trace.go:171","msg":"trace[1120149325] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:24188; }","duration":"393.618293ms","start":"2026-07-21T21:42:42.800335Z","end":"2026-07-21T21:42:43.193954Z","steps":["trace[1120149325] 'agreement among raft nodes before linearized reading' (duration: 393.443569ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:42:43.194009Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T21:42:42.800325Z","time spent":"393.676375ms","remote":"127.0.0.1:37486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":583,"request content":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" "} {"level":"warn","ts":"2026-07-21T21:42:43.194022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"417.672444ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/openstack/container-infra-registry\" ","response":"range_response_count:1 size:784"} {"level":"info","ts":"2026-07-21T21:42:43.194009Z","caller":"traceutil/trace.go:171","msg":"trace[1573042655] range","detail":"{range_begin:/registry/ingress/openstack/container-infra; range_end:; response_count:1; response_revision:24188; }","duration":"417.838887ms","start":"2026-07-21T21:42:42.776152Z","end":"2026-07-21T21:42:43.193991Z","steps":["trace[1573042655] 'agreement among raft nodes before linearized reading' (duration: 417.596832ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:42:43.194128Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T21:42:42.776136Z","time spent":"417.980701ms","remote":"127.0.0.1:37522","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":750,"request content":"key:\"/registry/ingress/openstack/container-infra\" "} {"level":"info","ts":"2026-07-21T21:42:43.194114Z","caller":"traceutil/trace.go:171","msg":"trace[233283067] range","detail":"{range_begin:/registry/ingress/openstack/container-infra-registry; range_end:; response_count:1; response_revision:24188; }","duration":"417.774297ms","start":"2026-07-21T21:42:42.776322Z","end":"2026-07-21T21:42:43.194097Z","steps":["trace[233283067] 'agreement among raft nodes before linearized reading' (duration: 417.542312ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:42:43.195599Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T21:42:42.776312Z","time spent":"419.266927ms","remote":"127.0.0.1:37522","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":805,"request content":"key:\"/registry/ingress/openstack/container-infra-registry\" "} {"level":"info","ts":"2026-07-21T21:42:49.959155Z","caller":"traceutil/trace.go:171","msg":"trace[975957087] linearizableReadLoop","detail":"{readStateIndex:25108; appliedIndex:25107; }","duration":"209.067736ms","start":"2026-07-21T21:42:49.750065Z","end":"2026-07-21T21:42:49.959132Z","steps":["trace[975957087] 'read index received' (duration: 209.027825ms)","trace[975957087] 'applied index is now lower than readState.Index' (duration: 38.971µs)"],"step_count":2} {"level":"info","ts":"2026-07-21T21:42:49.95924Z","caller":"traceutil/trace.go:171","msg":"trace[648383524] transaction","detail":"{read_only:false; response_revision:24321; number_of_response:1; }","duration":"215.302953ms","start":"2026-07-21T21:42:49.743908Z","end":"2026-07-21T21:42:49.959211Z","steps":["trace[648383524] 'process raft request' (duration: 215.109619ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:42:49.959307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.214429ms","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-07-21T21:42:49.959338Z","caller":"traceutil/trace.go:171","msg":"trace[480444235] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:24321; }","duration":"209.282051ms","start":"2026-07-21T21:42:49.750045Z","end":"2026-07-21T21:42:49.959327Z","steps":["trace[480444235] 'agreement among raft nodes before linearized reading' (duration: 209.203559ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:42:50.127796Z","caller":"traceutil/trace.go:171","msg":"trace[123092915] linearizableReadLoop","detail":"{readStateIndex:25109; appliedIndex:25108; }","duration":"168.54599ms","start":"2026-07-21T21:42:49.95922Z","end":"2026-07-21T21:42:50.127766Z","steps":["trace[123092915] 'read index received' (duration: 163.928506ms)","trace[123092915] 'applied index is now lower than readState.Index' (duration: 4.616454ms)"],"step_count":2} {"level":"info","ts":"2026-07-21T21:42:50.127937Z","caller":"traceutil/trace.go:171","msg":"trace[141280128] transaction","detail":"{read_only:false; response_revision:24322; number_of_response:1; }","duration":"313.735353ms","start":"2026-07-21T21:42:49.814167Z","end":"2026-07-21T21:42:50.127903Z","steps":["trace[141280128] 'process raft request' (duration: 309.054357ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:42:50.127994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.781982ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-07-21T21:42:50.128029Z","caller":"traceutil/trace.go:171","msg":"trace[1191060987] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:24322; }","duration":"285.898654ms","start":"2026-07-21T21:42:49.84212Z","end":"2026-07-21T21:42:50.128019Z","steps":["trace[1191060987] 'agreement among raft nodes before linearized reading' (duration: 285.754201ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:42:50.128091Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T21:42:49.814136Z","time spent":"313.876936ms","remote":"127.0.0.1:44100","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7681,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-21T21:42:50.810553Z","caller":"traceutil/trace.go:171","msg":"trace[1453409597] transaction","detail":"{read_only:false; response_revision:24323; number_of_response:1; }","duration":"309.430164ms","start":"2026-07-21T21:42:50.501096Z","end":"2026-07-21T21:42:50.810526Z","steps":["trace[1453409597] 'process raft request' (duration: 309.298022ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:42:50.810914Z","caller":"traceutil/trace.go:171","msg":"trace[83603524] linearizableReadLoop","detail":"{readStateIndex:25110; appliedIndex:25110; }","duration":"272.361119ms","start":"2026-07-21T21:42:50.538534Z","end":"2026-07-21T21:42:50.810895Z","steps":["trace[83603524] 'read index received' (duration: 272.348119ms)","trace[83603524] 'applied index is now lower than readState.Index' (duration: 10.24µs)"],"step_count":2} {"level":"warn","ts":"2026-07-21T21:42:50.810916Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T21:42:50.501081Z","time spent":"309.546696ms","remote":"127.0.0.1:37486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-21T21:42:50.811165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.605234ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-21T21:42:50.811249Z","caller":"traceutil/trace.go:171","msg":"trace[2117943535] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24323; }","duration":"272.749067ms","start":"2026-07-21T21:42:50.538481Z","end":"2026-07-21T21:42:50.81123Z","steps":["trace[2117943535] 'agreement among raft nodes before linearized reading' (duration: 272.570754ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:42:50.91981Z","caller":"traceutil/trace.go:171","msg":"trace[1701837889] transaction","detail":"{read_only:false; response_revision:24324; number_of_response:1; }","duration":"146.01481ms","start":"2026-07-21T21:42:50.773753Z","end":"2026-07-21T21:42:50.919768Z","steps":["trace[1701837889] 'process raft request' (duration: 145.778865ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:42:50.919904Z","caller":"traceutil/trace.go:171","msg":"trace[1919988017] transaction","detail":"{read_only:false; response_revision:24326; number_of_response:1; }","duration":"141.1327ms","start":"2026-07-21T21:42:50.778734Z","end":"2026-07-21T21:42:50.919867Z","steps":["trace[1919988017] 'process raft request' (duration: 140.982267ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:42:50.920225Z","caller":"traceutil/trace.go:171","msg":"trace[1592796532] transaction","detail":"{read_only:false; response_revision:24327; number_of_response:1; }","duration":"140.761053ms","start":"2026-07-21T21:42:50.779456Z","end":"2026-07-21T21:42:50.920217Z","steps":["trace[1592796532] 'process raft request' (duration: 140.297104ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:42:50.920295Z","caller":"traceutil/trace.go:171","msg":"trace[555661051] transaction","detail":"{read_only:false; response_revision:24329; number_of_response:1; }","duration":"124.974931ms","start":"2026-07-21T21:42:50.795296Z","end":"2026-07-21T21:42:50.920271Z","steps":["trace[555661051] 'process raft request' (duration: 124.520031ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:42:50.92011Z","caller":"traceutil/trace.go:171","msg":"trace[1569551592] transaction","detail":"{read_only:false; response_revision:24325; number_of_response:1; }","duration":"145.073381ms","start":"2026-07-21T21:42:50.775019Z","end":"2026-07-21T21:42:50.920092Z","steps":["trace[1569551592] 'process raft request' (duration: 144.651612ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:42:50.920192Z","caller":"traceutil/trace.go:171","msg":"trace[1004366950] transaction","detail":"{read_only:false; response_revision:24328; number_of_response:1; }","duration":"125.751025ms","start":"2026-07-21T21:42:50.794431Z","end":"2026-07-21T21:42:50.920182Z","steps":["trace[1004366950] 'process raft request' (duration: 125.352427ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:42:50.919865Z","caller":"traceutil/trace.go:171","msg":"trace[1186754931] linearizableReadLoop","detail":"{readStateIndex:25116; appliedIndex:25110; }","duration":"108.823621ms","start":"2026-07-21T21:42:50.811026Z","end":"2026-07-21T21:42:50.919849Z","steps":["trace[1186754931] 'read index received' (duration: 108.420163ms)","trace[1186754931] 'applied index is now lower than readState.Index' (duration: 402.688µs)"],"step_count":2} {"level":"warn","ts":"2026-07-21T21:42:50.920676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.190465ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-7a1fdc9d-31f1-4066-b500-97b535a274fd\" ","response":"range_response_count:1 size:3764"} {"level":"warn","ts":"2026-07-21T21:42:50.920718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.421384ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-21T21:42:50.920753Z","caller":"traceutil/trace.go:171","msg":"trace[107061606] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-7a1fdc9d-31f1-4066-b500-97b535a274fd; range_end:; response_count:1; response_revision:24329; }","duration":"343.309477ms","start":"2026-07-21T21:42:50.577422Z","end":"2026-07-21T21:42:50.920731Z","steps":["trace[107061606] 'agreement among raft nodes before linearized reading' (duration: 343.084753ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:42:50.920756Z","caller":"traceutil/trace.go:171","msg":"trace[1234824888] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24329; }","duration":"108.512595ms","start":"2026-07-21T21:42:50.812232Z","end":"2026-07-21T21:42:50.920745Z","steps":["trace[1234824888] 'agreement among raft nodes before linearized reading' (duration: 108.323961ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:42:50.920797Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T21:42:50.577402Z","time spent":"343.382458ms","remote":"127.0.0.1:37402","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3785,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-7a1fdc9d-31f1-4066-b500-97b535a274fd\" "} {"level":"warn","ts":"2026-07-21T21:42:50.920679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.54724ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates/\" range_end:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-21T21:42:50.921278Z","caller":"traceutil/trace.go:171","msg":"trace[303808661] range","detail":"{range_begin:/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates/; range_end:/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates0; response_count:0; response_revision:24329; }","duration":"312.277854ms","start":"2026-07-21T21:42:50.608973Z","end":"2026-07-21T21:42:50.921251Z","steps":["trace[303808661] 'agreement among raft nodes before linearized reading' (duration: 311.330765ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:42:50.921702Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T21:42:50.608957Z","time spent":"312.717183ms","remote":"127.0.0.1:46308","response type":"/etcdserverpb.KV/Range","request count":0,"request size":126,"response count":0,"response size":27,"request content":"key:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates/\" range_end:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates0\" count_only:true "} {"level":"info","ts":"2026-07-21T21:42:53.122976Z","caller":"traceutil/trace.go:171","msg":"trace[923206539] transaction","detail":"{read_only:false; response_revision:24340; number_of_response:1; }","duration":"197.661004ms","start":"2026-07-21T21:42:52.925288Z","end":"2026-07-21T21:42:53.122949Z","steps":["trace[923206539] 'process raft request' (duration: 197.495561ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:42:53.274584Z","caller":"traceutil/trace.go:171","msg":"trace[2053549263] transaction","detail":"{read_only:false; response_revision:24341; number_of_response:1; }","duration":"348.619805ms","start":"2026-07-21T21:42:52.925935Z","end":"2026-07-21T21:42:53.274554Z","steps":["trace[2053549263] 'process raft request' (duration: 348.392461ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:42:53.274759Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T21:42:52.925923Z","time spent":"348.740108ms","remote":"127.0.0.1:37486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":608,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-21T21:42:53.274586Z","caller":"traceutil/trace.go:171","msg":"trace[719441667] transaction","detail":"{read_only:false; response_revision:24342; number_of_response:1; }","duration":"348.243527ms","start":"2026-07-21T21:42:52.926326Z","end":"2026-07-21T21:42:53.27457Z","steps":["trace[719441667] 'process raft request' (duration: 348.152665ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:42:53.274974Z","caller":"traceutil/trace.go:171","msg":"trace[449296066] transaction","detail":"{read_only:false; response_revision:24343; number_of_response:1; }","duration":"348.549503ms","start":"2026-07-21T21:42:52.92639Z","end":"2026-07-21T21:42:53.27494Z","steps":["trace[449296066] 'process raft request' (duration: 348.144775ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:42:53.275012Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T21:42:52.926306Z","time spent":"348.592364ms","remote":"127.0.0.1:37486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-21T21:42:53.27509Z","caller":"traceutil/trace.go:171","msg":"trace[1732361396] linearizableReadLoop","detail":"{readStateIndex:25133; appliedIndex:25127; }","duration":"344.96664ms","start":"2026-07-21T21:42:52.930108Z","end":"2026-07-21T21:42:53.275075Z","steps":["trace[1732361396] 'read index received' (duration: 192.710753ms)","trace[1732361396] 'applied index is now lower than readState.Index' (duration: 152.254987ms)"],"step_count":2} {"level":"warn","ts":"2026-07-21T21:42:53.27512Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T21:42:52.926385Z","time spent":"348.678836ms","remote":"127.0.0.1:37486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":498,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-21T21:42:53.275158Z","caller":"traceutil/trace.go:171","msg":"trace[374031936] transaction","detail":"{read_only:false; response_revision:24345; number_of_response:1; }","duration":"348.37619ms","start":"2026-07-21T21:42:52.926739Z","end":"2026-07-21T21:42:53.275115Z","steps":["trace[374031936] 'process raft request' (duration: 348.180406ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:42:53.275284Z","caller":"traceutil/trace.go:171","msg":"trace[308127067] transaction","detail":"{read_only:false; response_revision:24344; number_of_response:1; }","duration":"348.558873ms","start":"2026-07-21T21:42:52.926709Z","end":"2026-07-21T21:42:53.275268Z","steps":["trace[308127067] 'process raft request' (duration: 348.143214ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:42:53.27537Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T21:42:52.926708Z","time spent":"348.552084ms","remote":"127.0.0.1:37486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-21T21:42:53.275379Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T21:42:52.926683Z","time spent":"348.644415ms","remote":"127.0.0.1:37486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-21T21:42:53.275752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.641174ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-7a1fdc9d-31f1-4066-b500-97b535a274fd\" ","response":"range_response_count:1 size:3950"} {"level":"info","ts":"2026-07-21T21:42:53.275804Z","caller":"traceutil/trace.go:171","msg":"trace[783551726] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-7a1fdc9d-31f1-4066-b500-97b535a274fd; range_end:; response_count:1; response_revision:24347; }","duration":"345.711695ms","start":"2026-07-21T21:42:52.930078Z","end":"2026-07-21T21:42:53.275789Z","steps":["trace[783551726] 'agreement among raft nodes before linearized reading' (duration: 345.596763ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:42:53.275843Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T21:42:52.930068Z","time spent":"345.765936ms","remote":"127.0.0.1:37402","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3971,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-7a1fdc9d-31f1-4066-b500-97b535a274fd\" "} {"level":"info","ts":"2026-07-21T21:42:53.2777Z","caller":"traceutil/trace.go:171","msg":"trace[1816079445] transaction","detail":"{read_only:false; response_revision:24346; number_of_response:1; }","duration":"286.073108ms","start":"2026-07-21T21:42:52.991609Z","end":"2026-07-21T21:42:53.277682Z","steps":["trace[1816079445] 'process raft request' (duration: 283.417904ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:42:56.075267Z","caller":"traceutil/trace.go:171","msg":"trace[382772678] linearizableReadLoop","detail":"{readStateIndex:25172; appliedIndex:25171; }","duration":"199.348258ms","start":"2026-07-21T21:42:55.87589Z","end":"2026-07-21T21:42:56.075238Z","steps":["trace[382772678] 'read index received' (duration: 199.107804ms)","trace[382772678] 'applied index is now lower than readState.Index' (duration: 239.584µs)"],"step_count":2} {"level":"info","ts":"2026-07-21T21:42:56.07539Z","caller":"traceutil/trace.go:171","msg":"trace[1608731673] transaction","detail":"{read_only:false; response_revision:24384; number_of_response:1; }","duration":"208.285021ms","start":"2026-07-21T21:42:55.867059Z","end":"2026-07-21T21:42:56.075344Z","steps":["trace[1608731673] 'process raft request' (duration: 208.019046ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:42:56.075517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.606883ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-manila-server-0\" ","response":"range_response_count:1 size:1860"} {"level":"info","ts":"2026-07-21T21:42:56.075609Z","caller":"traceutil/trace.go:171","msg":"trace[725194840] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-manila-server-0; range_end:; response_count:1; response_revision:24384; }","duration":"199.742616ms","start":"2026-07-21T21:42:55.875843Z","end":"2026-07-21T21:42:56.075586Z","steps":["trace[725194840] 'agreement among raft nodes before linearized reading' (duration: 199.511972ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:42:56.075507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.367249ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.235\" ","response":"range_response_count:1 size:140"} {"level":"info","ts":"2026-07-21T21:42:56.076035Z","caller":"traceutil/trace.go:171","msg":"trace[336266921] range","detail":"{range_begin:/registry/masterleases/199.204.45.235; range_end:; response_count:1; response_revision:24384; }","duration":"101.93868ms","start":"2026-07-21T21:42:55.974075Z","end":"2026-07-21T21:42:56.076014Z","steps":["trace[336266921] 'agreement among raft nodes before linearized reading' (duration: 101.305017ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:42:56.260945Z","caller":"traceutil/trace.go:171","msg":"trace[805995026] transaction","detail":"{read_only:false; response_revision:24385; number_of_response:1; }","duration":"179.184668ms","start":"2026-07-21T21:42:56.081731Z","end":"2026-07-21T21:42:56.260916Z","steps":["trace[805995026] 'process raft request' (duration: 178.011204ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:42:56.26103Z","caller":"traceutil/trace.go:171","msg":"trace[465345816] transaction","detail":"{read_only:false; response_revision:24386; number_of_response:1; }","duration":"178.85169ms","start":"2026-07-21T21:42:56.082148Z","end":"2026-07-21T21:42:56.260999Z","steps":["trace[465345816] 'process raft request' (duration: 178.709777ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:42:56.261365Z","caller":"traceutil/trace.go:171","msg":"trace[695297952] transaction","detail":"{read_only:false; response_revision:24387; number_of_response:1; }","duration":"178.550274ms","start":"2026-07-21T21:42:56.082802Z","end":"2026-07-21T21:42:56.261352Z","steps":["trace[695297952] 'process raft request' (duration: 178.117256ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:42:56.261705Z","caller":"traceutil/trace.go:171","msg":"trace[348218901] transaction","detail":"{read_only:false; response_revision:24388; number_of_response:1; }","duration":"178.710857ms","start":"2026-07-21T21:42:56.082977Z","end":"2026-07-21T21:42:56.261688Z","steps":["trace[348218901] 'process raft request' (duration: 178.066824ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:42:56.261704Z","caller":"traceutil/trace.go:171","msg":"trace[1010077412] transaction","detail":"{read_only:false; response_revision:24389; number_of_response:1; }","duration":"116.236742ms","start":"2026-07-21T21:42:56.145445Z","end":"2026-07-21T21:42:56.261682Z","steps":["trace[1010077412] 'process raft request' (duration: 116.13061ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:43:25.537949Z","caller":"traceutil/trace.go:171","msg":"trace[370243192] transaction","detail":"{read_only:false; response_revision:24616; number_of_response:1; }","duration":"219.476819ms","start":"2026-07-21T21:43:25.318431Z","end":"2026-07-21T21:43:25.537907Z","steps":["trace[370243192] 'process raft request' (duration: 141.911765ms)","trace[370243192] 'compare' (duration: 77.37836ms)"],"step_count":2} {"level":"info","ts":"2026-07-21T21:43:25.609163Z","caller":"traceutil/trace.go:171","msg":"trace[276700324] linearizableReadLoop","detail":"{readStateIndex:25417; appliedIndex:25410; }","duration":"195.98516ms","start":"2026-07-21T21:43:25.413152Z","end":"2026-07-21T21:43:25.609137Z","steps":["trace[276700324] 'read index received' (duration: 47.133382ms)","trace[276700324] 'applied index is now lower than readState.Index' (duration: 148.850588ms)"],"step_count":2} {"level":"info","ts":"2026-07-21T21:43:25.609471Z","caller":"traceutil/trace.go:171","msg":"trace[1152545846] transaction","detail":"{read_only:false; response_revision:24617; number_of_response:1; }","duration":"233.645969ms","start":"2026-07-21T21:43:25.375813Z","end":"2026-07-21T21:43:25.609459Z","steps":["trace[1152545846] 'process raft request' (duration: 233.021876ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:43:25.609652Z","caller":"traceutil/trace.go:171","msg":"trace[2074721415] transaction","detail":"{read_only:false; response_revision:24618; number_of_response:1; }","duration":"231.386132ms","start":"2026-07-21T21:43:25.378256Z","end":"2026-07-21T21:43:25.609642Z","steps":["trace[2074721415] 'process raft request' (duration: 230.698407ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:43:25.609912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.748356ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-07-21T21:43:25.609997Z","caller":"traceutil/trace.go:171","msg":"trace[1165582069] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24622; }","duration":"196.884949ms","start":"2026-07-21T21:43:25.413093Z","end":"2026-07-21T21:43:25.609978Z","steps":["trace[1165582069] 'agreement among raft nodes before linearized reading' (duration: 196.650854ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:43:25.610136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.111254ms","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-07-21T21:43:25.610148Z","caller":"traceutil/trace.go:171","msg":"trace[551158882] transaction","detail":"{read_only:false; response_revision:24619; number_of_response:1; }","duration":"231.024205ms","start":"2026-07-21T21:43:25.379114Z","end":"2026-07-21T21:43:25.610138Z","steps":["trace[551158882] 'process raft request' (duration: 229.880551ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:43:25.610172Z","caller":"traceutil/trace.go:171","msg":"trace[1046750125] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24622; }","duration":"176.163986ms","start":"2026-07-21T21:43:25.433997Z","end":"2026-07-21T21:43:25.610161Z","steps":["trace[1046750125] 'agreement among raft nodes before linearized reading' (duration: 176.078934ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:43:25.610237Z","caller":"traceutil/trace.go:171","msg":"trace[1839785912] transaction","detail":"{read_only:false; response_revision:24620; number_of_response:1; }","duration":"221.338767ms","start":"2026-07-21T21:43:25.388892Z","end":"2026-07-21T21:43:25.610231Z","steps":["trace[1839785912] 'process raft request' (duration: 220.148292ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:43:25.610332Z","caller":"traceutil/trace.go:171","msg":"trace[464206157] transaction","detail":"{read_only:false; response_revision:24621; number_of_response:1; }","duration":"220.400189ms","start":"2026-07-21T21:43:25.389926Z","end":"2026-07-21T21:43:25.610326Z","steps":["trace[464206157] 'process raft request' (duration: 219.143733ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:43:25.610346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.743818ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:559"} {"level":"info","ts":"2026-07-21T21:43:25.610374Z","caller":"traceutil/trace.go:171","msg":"trace[2112961077] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:24622; }","duration":"179.79551ms","start":"2026-07-21T21:43:25.430569Z","end":"2026-07-21T21:43:25.610364Z","steps":["trace[2112961077] 'agreement among raft nodes before linearized reading' (duration: 179.712628ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:43:25.610408Z","caller":"traceutil/trace.go:171","msg":"trace[342197459] transaction","detail":"{read_only:false; response_revision:24622; number_of_response:1; }","duration":"215.792813ms","start":"2026-07-21T21:43:25.394609Z","end":"2026-07-21T21:43:25.610401Z","steps":["trace[342197459] 'process raft request' (duration: 214.494776ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:43:25.609923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.826083ms","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-07-21T21:43:25.610475Z","caller":"traceutil/trace.go:171","msg":"trace[367896204] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24622; }","duration":"187.435796ms","start":"2026-07-21T21:43:25.423034Z","end":"2026-07-21T21:43:25.61047Z","steps":["trace[367896204] 'agreement among raft nodes before linearized reading' (duration: 186.783863ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:43:25.610565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.016144ms","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-07-21T21:43:25.610605Z","caller":"traceutil/trace.go:171","msg":"trace[1780614277] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24622; }","duration":"180.091665ms","start":"2026-07-21T21:43:25.430505Z","end":"2026-07-21T21:43:25.610596Z","steps":["trace[1780614277] 'agreement among raft nodes before linearized reading' (duration: 180.001164ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:43:25.763415Z","caller":"traceutil/trace.go:171","msg":"trace[416837012] transaction","detail":"{read_only:false; response_revision:24624; number_of_response:1; }","duration":"148.0228ms","start":"2026-07-21T21:43:25.615358Z","end":"2026-07-21T21:43:25.763381Z","steps":["trace[416837012] 'process raft request' (duration: 120.246994ms)","trace[416837012] 'compare' (duration: 27.392018ms)"],"step_count":2} {"level":"info","ts":"2026-07-21T21:43:25.763793Z","caller":"traceutil/trace.go:171","msg":"trace[1602838537] transaction","detail":"{read_only:false; response_revision:24625; number_of_response:1; }","duration":"148.252016ms","start":"2026-07-21T21:43:25.615498Z","end":"2026-07-21T21:43:25.76375Z","steps":["trace[1602838537] 'process raft request' (duration: 147.773355ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:43:25.764042Z","caller":"traceutil/trace.go:171","msg":"trace[903499831] transaction","detail":"{read_only:false; response_revision:24627; number_of_response:1; }","duration":"147.027031ms","start":"2026-07-21T21:43:25.617001Z","end":"2026-07-21T21:43:25.764028Z","steps":["trace[903499831] 'process raft request' (duration: 146.773256ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:43:25.764018Z","caller":"traceutil/trace.go:171","msg":"trace[278085052] transaction","detail":"{read_only:false; response_revision:24626; number_of_response:1; }","duration":"147.706644ms","start":"2026-07-21T21:43:25.616282Z","end":"2026-07-21T21:43:25.763989Z","steps":["trace[278085052] 'process raft request' (duration: 147.350787ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:43:26.234737Z","caller":"traceutil/trace.go:171","msg":"trace[1946953427] transaction","detail":"{read_only:false; response_revision:24628; number_of_response:1; }","duration":"137.742931ms","start":"2026-07-21T21:43:26.096964Z","end":"2026-07-21T21:43:26.234707Z","steps":["trace[1946953427] 'process raft request' (duration: 115.718592ms)","trace[1946953427] 'compare' (duration: 21.769444ms)"],"step_count":2} {"level":"warn","ts":"2026-07-21T21:43:26.534249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.399334ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-07-21T21:43:26.534345Z","caller":"traceutil/trace.go:171","msg":"trace[1172975483] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:24628; }","duration":"137.520626ms","start":"2026-07-21T21:43:26.396803Z","end":"2026-07-21T21:43:26.534323Z","steps":["trace[1172975483] 'count revisions from in-memory index tree' (duration: 137.313853ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:43:27.457368Z","caller":"traceutil/trace.go:171","msg":"trace[683094956] transaction","detail":"{read_only:false; response_revision:24629; number_of_response:1; }","duration":"139.432415ms","start":"2026-07-21T21:43:27.317905Z","end":"2026-07-21T21:43:27.457338Z","steps":["trace[683094956] 'process raft request' (duration: 139.209221ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:43:27.704196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.309683ms","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-07-21T21:43:27.704341Z","caller":"traceutil/trace.go:171","msg":"trace[265578500] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24629; }","duration":"162.456236ms","start":"2026-07-21T21:43:27.541851Z","end":"2026-07-21T21:43:27.704307Z","steps":["trace[265578500] 'range keys from in-memory index tree' (duration: 162.130259ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:43:27.94142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.548862ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-21T21:43:27.941859Z","caller":"traceutil/trace.go:171","msg":"trace[394162793] transaction","detail":"{read_only:false; response_revision:24631; number_of_response:1; }","duration":"325.511613ms","start":"2026-07-21T21:43:27.616305Z","end":"2026-07-21T21:43:27.941816Z","steps":["trace[394162793] 'process raft request' (duration: 198.42226ms)","trace[394162793] 'compare' (duration: 126.280717ms)"],"step_count":2} {"level":"info","ts":"2026-07-21T21:43:27.941944Z","caller":"traceutil/trace.go:171","msg":"trace[1056496767] transaction","detail":"{read_only:false; response_revision:24632; number_of_response:1; }","duration":"325.573074ms","start":"2026-07-21T21:43:27.616352Z","end":"2026-07-21T21:43:27.941925Z","steps":["trace[1056496767] 'process raft request' (duration: 325.36826ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:43:27.942036Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T21:43:27.616329Z","time spent":"325.655606ms","remote":"127.0.0.1:37486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":498,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-21T21:43:27.942035Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T21:43:27.616279Z","time spent":"325.671446ms","remote":"127.0.0.1:37486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-21T21:43:27.942218Z","caller":"traceutil/trace.go:171","msg":"trace[1833517159] transaction","detail":"{read_only:false; response_revision:24633; number_of_response:1; }","duration":"325.776768ms","start":"2026-07-21T21:43:27.616351Z","end":"2026-07-21T21:43:27.942127Z","steps":["trace[1833517159] 'process raft request' (duration: 325.638416ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:43:27.942655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.877735ms","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-07-21T21:43:27.942383Z","caller":"traceutil/trace.go:171","msg":"trace[1622020263] linearizableReadLoop","detail":"{readStateIndex:25431; appliedIndex:25425; }","duration":"312.590419ms","start":"2026-07-21T21:43:27.629779Z","end":"2026-07-21T21:43:27.94237Z","steps":["trace[1622020263] 'read index received' (duration: 67.305194ms)","trace[1622020263] 'applied index is now lower than readState.Index' (duration: 245.284125ms)"],"step_count":2} {"level":"info","ts":"2026-07-21T21:43:27.942706Z","caller":"traceutil/trace.go:171","msg":"trace[1872363896] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24635; }","duration":"312.972627ms","start":"2026-07-21T21:43:27.629723Z","end":"2026-07-21T21:43:27.942695Z","steps":["trace[1872363896] 'agreement among raft nodes before linearized reading' (duration: 312.688221ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:43:27.942416Z","caller":"traceutil/trace.go:171","msg":"trace[425284337] transaction","detail":"{read_only:false; response_revision:24634; number_of_response:1; }","duration":"326.048184ms","start":"2026-07-21T21:43:27.616352Z","end":"2026-07-21T21:43:27.942401Z","steps":["trace[425284337] 'process raft request' (duration: 325.702447ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:43:27.942746Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T21:43:27.6297Z","time spent":"313.038049ms","remote":"127.0.0.1:37486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-21T21:43:27.942831Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T21:43:27.616331Z","time spent":"326.433761ms","remote":"127.0.0.1:37486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-21T21:43:27.942433Z","caller":"traceutil/trace.go:171","msg":"trace[1905951939] transaction","detail":"{read_only:false; response_revision:24635; number_of_response:1; }","duration":"325.275868ms","start":"2026-07-21T21:43:27.617137Z","end":"2026-07-21T21:43:27.942413Z","steps":["trace[1905951939] 'process raft request' (duration: 325.138035ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:43:27.942968Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T21:43:27.617115Z","time spent":"325.81418ms","remote":"127.0.0.1:37486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-21T21:43:27.942669Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T21:43:27.616329Z","time spent":"326.277178ms","remote":"127.0.0.1:37486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":608,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-21T21:43:28.193824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.505707ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-21T21:43:28.194049Z","caller":"traceutil/trace.go:171","msg":"trace[1506795179] transaction","detail":"{read_only:false; response_revision:24638; number_of_response:1; }","duration":"246.420779ms","start":"2026-07-21T21:43:27.947614Z","end":"2026-07-21T21:43:28.194034Z","steps":["trace[1506795179] 'process raft request' (duration: 246.383548ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:43:28.194161Z","caller":"traceutil/trace.go:171","msg":"trace[910012000] transaction","detail":"{read_only:false; response_revision:24636; number_of_response:1; }","duration":"485.05164ms","start":"2026-07-21T21:43:27.709077Z","end":"2026-07-21T21:43:28.194129Z","steps":["trace[910012000] 'process raft request' (duration: 371.169365ms)","trace[910012000] 'compare' (duration: 113.178801ms)"],"step_count":2} {"level":"info","ts":"2026-07-21T21:43:28.194244Z","caller":"traceutil/trace.go:171","msg":"trace[1982287327] transaction","detail":"{read_only:false; response_revision:24637; number_of_response:1; }","duration":"383.195631ms","start":"2026-07-21T21:43:27.811041Z","end":"2026-07-21T21:43:28.194237Z","steps":["trace[1982287327] 'process raft request' (duration: 382.877835ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:43:28.194292Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T21:43:27.81102Z","time spent":"383.245073ms","remote":"127.0.0.1:37486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":627,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-21T21:43:28.194307Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T21:43:27.709057Z","time spent":"485.177782ms","remote":"127.0.0.1:37486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-21T21:43:28.194347Z","caller":"traceutil/trace.go:171","msg":"trace[2070775751] linearizableReadLoop","detail":"{readStateIndex:25433; appliedIndex:25431; }","duration":"251.605306ms","start":"2026-07-21T21:43:27.942708Z","end":"2026-07-21T21:43:28.194314Z","steps":["trace[2070775751] 'read index received' (duration: 137.547338ms)","trace[2070775751] 'applied index is now lower than readState.Index' (duration: 114.052897ms)"],"step_count":2} {"level":"warn","ts":"2026-07-21T21:43:28.194438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"426.307581ms","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-07-21T21:43:28.194461Z","caller":"traceutil/trace.go:171","msg":"trace[1809429370] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24638; }","duration":"426.351381ms","start":"2026-07-21T21:43:27.768103Z","end":"2026-07-21T21:43:28.194455Z","steps":["trace[1809429370] 'agreement among raft nodes before linearized reading' (duration: 426.26318ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:43:28.194482Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T21:43:27.76809Z","time spent":"426.388212ms","remote":"127.0.0.1:37486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-21T21:43:28.194501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"426.31271ms","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-07-21T21:43:28.194539Z","caller":"traceutil/trace.go:171","msg":"trace[1563153387] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24638; }","duration":"426.390052ms","start":"2026-07-21T21:43:27.768139Z","end":"2026-07-21T21:43:28.194529Z","steps":["trace[1563153387] 'agreement among raft nodes before linearized reading' (duration: 426.27252ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:43:28.194571Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T21:43:27.768117Z","time spent":"426.448494ms","remote":"127.0.0.1:37486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-21T21:43:28.194639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"426.862941ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-07-21T21:43:28.194685Z","caller":"traceutil/trace.go:171","msg":"trace[1191606857] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24638; }","duration":"426.951844ms","start":"2026-07-21T21:43:27.767722Z","end":"2026-07-21T21:43:28.194673Z","steps":["trace[1191606857] 'agreement among raft nodes before linearized reading' (duration: 426.76373ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:43:28.194723Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T21:43:27.767711Z","time spent":"427.002255ms","remote":"127.0.0.1:37486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-21T21:43:28.194741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"427.523155ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:559"} {"level":"info","ts":"2026-07-21T21:43:28.194762Z","caller":"traceutil/trace.go:171","msg":"trace[1184883778] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:24638; }","duration":"427.579416ms","start":"2026-07-21T21:43:27.767176Z","end":"2026-07-21T21:43:28.194756Z","steps":["trace[1184883778] 'agreement among raft nodes before linearized reading' (duration: 427.519835ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:43:28.19478Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T21:43:27.767156Z","time spent":"427.620617ms","remote":"127.0.0.1:37486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":580,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"warn","ts":"2026-07-21T21:43:28.194772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.938984ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-21T21:43:28.194852Z","caller":"traceutil/trace.go:171","msg":"trace[696466987] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:24638; }","duration":"112.083808ms","start":"2026-07-21T21:43:28.082748Z","end":"2026-07-21T21:43:28.194832Z","steps":["trace[696466987] 'agreement among raft nodes before linearized reading' (duration: 111.954255ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:43:28.398417Z","caller":"traceutil/trace.go:171","msg":"trace[1616681369] transaction","detail":"{read_only:false; response_revision:24640; number_of_response:1; }","duration":"199.650405ms","start":"2026-07-21T21:43:28.198736Z","end":"2026-07-21T21:43:28.398386Z","steps":["trace[1616681369] 'process raft request' (duration: 186.007276ms)","trace[1616681369] 'compare' (duration: 13.321792ms)"],"step_count":2} {"level":"info","ts":"2026-07-21T21:43:28.398467Z","caller":"traceutil/trace.go:171","msg":"trace[1302368633] transaction","detail":"{read_only:false; response_revision:24641; number_of_response:1; }","duration":"199.538412ms","start":"2026-07-21T21:43:28.198915Z","end":"2026-07-21T21:43:28.398453Z","steps":["trace[1302368633] 'process raft request' (duration: 199.398639ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:43:28.398457Z","caller":"traceutil/trace.go:171","msg":"trace[1519543466] linearizableReadLoop","detail":"{readStateIndex:25438; appliedIndex:25434; }","duration":"163.514517ms","start":"2026-07-21T21:43:28.23492Z","end":"2026-07-21T21:43:28.398435Z","steps":["trace[1519543466] 'read index received' (duration: 4.806317ms)","trace[1519543466] 'applied index is now lower than readState.Index' (duration: 158.70728ms)"],"step_count":2} {"level":"info","ts":"2026-07-21T21:43:28.398512Z","caller":"traceutil/trace.go:171","msg":"trace[1067650479] transaction","detail":"{read_only:false; response_revision:24642; number_of_response:1; }","duration":"198.369268ms","start":"2026-07-21T21:43:28.200105Z","end":"2026-07-21T21:43:28.398474Z","steps":["trace[1067650479] 'process raft request' (duration: 198.284817ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:43:28.398772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.828713ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:561"} {"level":"info","ts":"2026-07-21T21:43:28.398862Z","caller":"traceutil/trace.go:171","msg":"trace[1728609552] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:24642; }","duration":"163.921785ms","start":"2026-07-21T21:43:28.234913Z","end":"2026-07-21T21:43:28.398835Z","steps":["trace[1728609552] 'agreement among raft nodes before linearized reading' (duration: 163.617879ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:43:28.756994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.919895ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-21T21:43:28.757069Z","caller":"traceutil/trace.go:171","msg":"trace[1390702845] linearizableReadLoop","detail":"{readStateIndex:25440; appliedIndex:25439; }","duration":"345.776327ms","start":"2026-07-21T21:43:28.411281Z","end":"2026-07-21T21:43:28.757058Z","steps":["trace[1390702845] 'read index received' (duration: 133.682958ms)","trace[1390702845] 'applied index is now lower than readState.Index' (duration: 212.092739ms)"],"step_count":2} {"level":"warn","ts":"2026-07-21T21:43:28.75715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.939939ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/prometheuses/\" range_end:\"/registry/monitoring.coreos.com/prometheuses0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-07-21T21:43:28.757199Z","caller":"traceutil/trace.go:171","msg":"trace[1714397270] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheuses/; range_end:/registry/monitoring.coreos.com/prometheuses0; response_count:0; response_revision:24644; }","duration":"345.99129ms","start":"2026-07-21T21:43:28.411195Z","end":"2026-07-21T21:43:28.757187Z","steps":["trace[1714397270] 'agreement among raft nodes before linearized reading' (duration: 345.911679ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:43:28.757206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.412398ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-c8b4664d-d96a-49e6-ae41-f88d9c2a4f57\" ","response":"range_response_count:1 size:1284"} {"level":"info","ts":"2026-07-21T21:43:28.757168Z","caller":"traceutil/trace.go:171","msg":"trace[1450462197] transaction","detail":"{read_only:false; response_revision:24644; number_of_response:1; }","duration":"354.107387ms","start":"2026-07-21T21:43:28.402998Z","end":"2026-07-21T21:43:28.757105Z","steps":["trace[1450462197] 'process raft request' (duration: 142.021328ms)","trace[1450462197] 'compare' (duration: 211.801843ms)"],"step_count":2} {"level":"warn","ts":"2026-07-21T21:43:28.757238Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T21:43:28.411153Z","time spent":"346.076302ms","remote":"127.0.0.1:50658","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":1,"response size":29,"request content":"key:\"/registry/monitoring.coreos.com/prometheuses/\" range_end:\"/registry/monitoring.coreos.com/prometheuses0\" count_only:true "} {"level":"warn","ts":"2026-07-21T21:43:28.75724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.911927ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-21T21:43:28.757285Z","caller":"traceutil/trace.go:171","msg":"trace[63939672] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24644; }","duration":"219.020719ms","start":"2026-07-21T21:43:28.538254Z","end":"2026-07-21T21:43:28.757275Z","steps":["trace[63939672] 'agreement among raft nodes before linearized reading' (duration: 218.939278ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:43:28.75735Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T21:43:28.402974Z","time spent":"354.28836ms","remote":"127.0.0.1:37486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":543,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-21T21:43:28.757235Z","caller":"traceutil/trace.go:171","msg":"trace[642709201] range","detail":"{range_begin:/registry/persistentvolumes/pvc-c8b4664d-d96a-49e6-ae41-f88d9c2a4f57; range_end:; response_count:1; response_revision:24644; }","duration":"343.465789ms","start":"2026-07-21T21:43:28.413761Z","end":"2026-07-21T21:43:28.757227Z","steps":["trace[642709201] 'agreement among raft nodes before linearized reading' (duration: 343.369007ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:43:28.757471Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T21:43:28.413748Z","time spent":"343.666453ms","remote":"127.0.0.1:37374","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":1305,"request content":"key:\"/registry/persistentvolumes/pvc-c8b4664d-d96a-49e6-ae41-f88d9c2a4f57\" "} {"level":"info","ts":"2026-07-21T21:43:29.819682Z","caller":"traceutil/trace.go:171","msg":"trace[1857795446] transaction","detail":"{read_only:false; response_revision:24646; number_of_response:1; }","duration":"110.219429ms","start":"2026-07-21T21:43:29.709434Z","end":"2026-07-21T21:43:29.819654Z","steps":["trace[1857795446] 'process raft request' (duration: 109.667278ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:43:29.986636Z","caller":"traceutil/trace.go:171","msg":"trace[2131983534] transaction","detail":"{read_only:false; response_revision:24647; number_of_response:1; }","duration":"163.558798ms","start":"2026-07-21T21:43:29.823052Z","end":"2026-07-21T21:43:29.98661Z","steps":["trace[2131983534] 'process raft request' (duration: 163.417685ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:43:30.181239Z","caller":"traceutil/trace.go:171","msg":"trace[1534845131] transaction","detail":"{read_only:false; response_revision:24648; number_of_response:1; }","duration":"233.945214ms","start":"2026-07-21T21:43:29.947265Z","end":"2026-07-21T21:43:30.18121Z","steps":["trace[1534845131] 'process raft request' (duration: 214.304113ms)","trace[1534845131] 'compare' (duration: 19.470037ms)"],"step_count":2} {"level":"info","ts":"2026-07-21T21:43:30.181503Z","caller":"traceutil/trace.go:171","msg":"trace[614036977] transaction","detail":"{read_only:false; response_revision:24649; number_of_response:1; }","duration":"232.642799ms","start":"2026-07-21T21:43:29.948826Z","end":"2026-07-21T21:43:30.181469Z","steps":["trace[614036977] 'process raft request' (duration: 232.335102ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:43:30.181737Z","caller":"traceutil/trace.go:171","msg":"trace[729149484] transaction","detail":"{read_only:false; response_revision:24652; number_of_response:1; }","duration":"231.690679ms","start":"2026-07-21T21:43:29.95003Z","end":"2026-07-21T21:43:30.18172Z","steps":["trace[729149484] 'process raft request' (duration: 231.646608ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:43:30.181727Z","caller":"traceutil/trace.go:171","msg":"trace[280692386] transaction","detail":"{read_only:false; response_revision:24650; number_of_response:1; }","duration":"232.722199ms","start":"2026-07-21T21:43:29.948973Z","end":"2026-07-21T21:43:30.181695Z","steps":["trace[280692386] 'process raft request' (duration: 232.392782ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:43:30.181782Z","caller":"traceutil/trace.go:171","msg":"trace[1436932337] transaction","detail":"{read_only:false; response_revision:24651; number_of_response:1; }","duration":"231.977125ms","start":"2026-07-21T21:43:29.949795Z","end":"2026-07-21T21:43:30.181772Z","steps":["trace[1436932337] 'process raft request' (duration: 231.796751ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:43:30.421732Z","caller":"traceutil/trace.go:171","msg":"trace[1895107124] transaction","detail":"{read_only:false; response_revision:24654; number_of_response:1; }","duration":"218.281185ms","start":"2026-07-21T21:43:30.203417Z","end":"2026-07-21T21:43:30.421698Z","steps":["trace[1895107124] 'process raft request' (duration: 129.751779ms)","trace[1895107124] 'compare' (duration: 88.303042ms)"],"step_count":2} {"level":"info","ts":"2026-07-21T21:43:30.421777Z","caller":"traceutil/trace.go:171","msg":"trace[1730171493] linearizableReadLoop","detail":"{readStateIndex:25450; appliedIndex:25448; }","duration":"177.931281ms","start":"2026-07-21T21:43:30.243814Z","end":"2026-07-21T21:43:30.421745Z","steps":["trace[1730171493] 'read index received' (duration: 4.702516ms)","trace[1730171493] 'applied index is now lower than readState.Index' (duration: 173.223995ms)"],"step_count":2} {"level":"warn","ts":"2026-07-21T21:43:30.421914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.086834ms","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-07-21T21:43:30.42198Z","caller":"traceutil/trace.go:171","msg":"trace[277414549] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24655; }","duration":"178.182785ms","start":"2026-07-21T21:43:30.243783Z","end":"2026-07-21T21:43:30.421966Z","steps":["trace[277414549] 'agreement among raft nodes before linearized reading' (duration: 178.026552ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:43:32.420261Z","caller":"traceutil/trace.go:171","msg":"trace[442388229] transaction","detail":"{read_only:false; response_revision:24663; number_of_response:1; }","duration":"232.577126ms","start":"2026-07-21T21:43:32.187625Z","end":"2026-07-21T21:43:32.420202Z","steps":["trace[442388229] 'process raft request' (duration: 211.841662ms)","trace[442388229] 'compare' (duration: 20.374907ms)"],"step_count":2} {"level":"info","ts":"2026-07-21T21:43:32.420288Z","caller":"traceutil/trace.go:171","msg":"trace[2137809160] linearizableReadLoop","detail":"{readStateIndex:25463; appliedIndex:25458; }","duration":"225.016994ms","start":"2026-07-21T21:43:32.195243Z","end":"2026-07-21T21:43:32.42026Z","steps":["trace[2137809160] 'read index received' (duration: 68.277564ms)","trace[2137809160] 'applied index is now lower than readState.Index' (duration: 156.73844ms)"],"step_count":2} {"level":"info","ts":"2026-07-21T21:43:32.420418Z","caller":"traceutil/trace.go:171","msg":"trace[338907561] transaction","detail":"{read_only:false; response_revision:24665; number_of_response:1; }","duration":"232.389774ms","start":"2026-07-21T21:43:32.188015Z","end":"2026-07-21T21:43:32.420405Z","steps":["trace[338907561] 'process raft request' (duration: 232.173199ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:43:32.420462Z","caller":"traceutil/trace.go:171","msg":"trace[274553857] transaction","detail":"{read_only:false; response_revision:24664; number_of_response:1; }","duration":"232.72165ms","start":"2026-07-21T21:43:32.187658Z","end":"2026-07-21T21:43:32.42038Z","steps":["trace[274553857] 'process raft request' (duration: 232.309112ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:43:32.420563Z","caller":"traceutil/trace.go:171","msg":"trace[1402734100] transaction","detail":"{read_only:false; response_revision:24666; number_of_response:1; }","duration":"231.640289ms","start":"2026-07-21T21:43:32.188914Z","end":"2026-07-21T21:43:32.420555Z","steps":["trace[1402734100] 'process raft request' (duration: 231.308432ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:43:32.420714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.457312ms","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-07-21T21:43:32.420751Z","caller":"traceutil/trace.go:171","msg":"trace[859211784] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:24666; }","duration":"225.537884ms","start":"2026-07-21T21:43:32.1952Z","end":"2026-07-21T21:43:32.420738Z","steps":["trace[859211784] 'agreement among raft nodes before linearized reading' (duration: 225.427842ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:43:32.420929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.494519ms","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-07-21T21:43:32.42097Z","caller":"traceutil/trace.go:171","msg":"trace[857358255] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24666; }","duration":"167.582321ms","start":"2026-07-21T21:43:32.253375Z","end":"2026-07-21T21:43:32.420957Z","steps":["trace[857358255] 'agreement among raft nodes before linearized reading' (duration: 167.436488ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:43:32.650057Z","caller":"traceutil/trace.go:171","msg":"trace[942002228] transaction","detail":"{read_only:false; response_revision:24668; number_of_response:1; }","duration":"150.037313ms","start":"2026-07-21T21:43:32.499988Z","end":"2026-07-21T21:43:32.650025Z","steps":["trace[942002228] 'process raft request' (duration: 143.196553ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:43:32.668501Z","caller":"traceutil/trace.go:171","msg":"trace[1683473555] transaction","detail":"{read_only:false; response_revision:24670; number_of_response:1; }","duration":"168.453648ms","start":"2026-07-21T21:43:32.500018Z","end":"2026-07-21T21:43:32.668472Z","steps":["trace[1683473555] 'process raft request' (duration: 168.371596ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:43:32.668559Z","caller":"traceutil/trace.go:171","msg":"trace[34387589] transaction","detail":"{read_only:false; response_revision:24669; number_of_response:1; }","duration":"168.506469ms","start":"2026-07-21T21:43:32.500008Z","end":"2026-07-21T21:43:32.668514Z","steps":["trace[34387589] 'process raft request' (duration: 168.167122ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:43:32.668718Z","caller":"traceutil/trace.go:171","msg":"trace[695855507] transaction","detail":"{read_only:false; response_revision:24671; number_of_response:1; }","duration":"168.6051ms","start":"2026-07-21T21:43:32.500095Z","end":"2026-07-21T21:43:32.6687Z","steps":["trace[695855507] 'process raft request' (duration: 168.344745ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:43:32.66888Z","caller":"traceutil/trace.go:171","msg":"trace[1714327958] linearizableReadLoop","detail":"{readStateIndex:25469; appliedIndex:25464; }","duration":"130.204857ms","start":"2026-07-21T21:43:32.538659Z","end":"2026-07-21T21:43:32.668864Z","steps":["trace[1714327958] 'read index received' (duration: 104.524423ms)","trace[1714327958] 'applied index is now lower than readState.Index' (duration: 25.679134ms)"],"step_count":2} {"level":"info","ts":"2026-07-21T21:43:32.668894Z","caller":"traceutil/trace.go:171","msg":"trace[218954006] transaction","detail":"{read_only:false; response_revision:24672; number_of_response:1; }","duration":"168.787565ms","start":"2026-07-21T21:43:32.500082Z","end":"2026-07-21T21:43:32.668869Z","steps":["trace[218954006] 'process raft request' (duration: 168.55076ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:43:32.668984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.306329ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-21T21:43:32.669023Z","caller":"traceutil/trace.go:171","msg":"trace[1524222945] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24672; }","duration":"130.409812ms","start":"2026-07-21T21:43:32.538601Z","end":"2026-07-21T21:43:32.669011Z","steps":["trace[1524222945] 'agreement among raft nodes before linearized reading' (duration: 130.313409ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:43:33.304078Z","caller":"traceutil/trace.go:171","msg":"trace[862199940] transaction","detail":"{read_only:false; response_revision:24673; number_of_response:1; }","duration":"105.295248ms","start":"2026-07-21T21:43:33.198762Z","end":"2026-07-21T21:43:33.304057Z","steps":["trace[862199940] 'process raft request' (duration: 105.177445ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:43:33.75034Z","caller":"traceutil/trace.go:171","msg":"trace[987645633] transaction","detail":"{read_only:false; response_revision:24674; number_of_response:1; }","duration":"178.618084ms","start":"2026-07-21T21:43:33.571689Z","end":"2026-07-21T21:43:33.750307Z","steps":["trace[987645633] 'process raft request' (duration: 178.43127ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:45:02.704552Z","caller":"traceutil/trace.go:171","msg":"trace[1118666456] transaction","detail":"{read_only:false; response_revision:25577; number_of_response:1; }","duration":"114.194389ms","start":"2026-07-21T21:45:02.590336Z","end":"2026-07-21T21:45:02.70453Z","steps":["trace[1118666456] 'process raft request' (duration: 114.079677ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:45:03.331989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.453324ms","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-07-21T21:45:03.332077Z","caller":"traceutil/trace.go:171","msg":"trace[1059818855] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25583; }","duration":"110.573306ms","start":"2026-07-21T21:45:03.221482Z","end":"2026-07-21T21:45:03.332055Z","steps":["trace[1059818855] 'range keys from in-memory index tree' (duration: 110.288161ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:45:03.332306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.557394ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/federations/\" range_end:\"/registry/rabbitmq.com/federations0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-07-21T21:45:03.332325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.795047ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"warn","ts":"2026-07-21T21:45:03.332339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.695321ms","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-07-21T21:45:03.332387Z","caller":"traceutil/trace.go:171","msg":"trace[1344248419] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25583; }","duration":"174.862008ms","start":"2026-07-21T21:45:03.15751Z","end":"2026-07-21T21:45:03.332372Z","steps":["trace[1344248419] 'range keys from in-memory index tree' (duration: 174.657675ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:45:03.332389Z","caller":"traceutil/trace.go:171","msg":"trace[1676486803] range","detail":"{range_begin:/registry/rabbitmq.com/federations/; range_end:/registry/rabbitmq.com/federations0; response_count:0; response_revision:25583; }","duration":"155.685487ms","start":"2026-07-21T21:45:03.176681Z","end":"2026-07-21T21:45:03.332367Z","steps":["trace[1676486803] 'count revisions from in-memory index tree' (duration: 155.477623ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:45:03.332388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.056587ms","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-07-21T21:45:03.33241Z","caller":"traceutil/trace.go:171","msg":"trace[144464841] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25583; }","duration":"116.807494ms","start":"2026-07-21T21:45:03.215585Z","end":"2026-07-21T21:45:03.332393Z","steps":["trace[144464841] 'range keys from in-memory index tree' (duration: 116.547569ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:45:03.332445Z","caller":"traceutil/trace.go:171","msg":"trace[332299434] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25583; }","duration":"114.142319ms","start":"2026-07-21T21:45:03.218287Z","end":"2026-07-21T21:45:03.33243Z","steps":["trace[332299434] 'range keys from in-memory index tree' (duration: 113.868884ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:45:03.438144Z","caller":"traceutil/trace.go:171","msg":"trace[1028156556] transaction","detail":"{read_only:false; response_revision:25584; number_of_response:1; }","duration":"101.550532ms","start":"2026-07-21T21:45:03.336577Z","end":"2026-07-21T21:45:03.438128Z","steps":["trace[1028156556] 'process raft request' (duration: 101.45651ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:45:03.455178Z","caller":"traceutil/trace.go:171","msg":"trace[745119027] transaction","detail":"{read_only:false; response_revision:25585; number_of_response:1; }","duration":"118.11664ms","start":"2026-07-21T21:45:03.337037Z","end":"2026-07-21T21:45:03.455153Z","steps":["trace[745119027] 'process raft request' (duration: 117.167521ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:45:03.455519Z","caller":"traceutil/trace.go:171","msg":"trace[69882918] transaction","detail":"{read_only:false; response_revision:25588; number_of_response:1; }","duration":"115.15634ms","start":"2026-07-21T21:45:03.340351Z","end":"2026-07-21T21:45:03.455508Z","steps":["trace[69882918] 'process raft request' (duration: 114.984497ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:45:03.455663Z","caller":"traceutil/trace.go:171","msg":"trace[386158026] transaction","detail":"{read_only:false; response_revision:25586; number_of_response:1; }","duration":"117.523247ms","start":"2026-07-21T21:45:03.338129Z","end":"2026-07-21T21:45:03.455653Z","steps":["trace[386158026] 'process raft request' (duration: 116.990087ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:45:03.455837Z","caller":"traceutil/trace.go:171","msg":"trace[744843230] transaction","detail":"{read_only:false; response_revision:25587; number_of_response:1; }","duration":"116.259464ms","start":"2026-07-21T21:45:03.339566Z","end":"2026-07-21T21:45:03.455826Z","steps":["trace[744843230] 'process raft request' (duration: 115.718992ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:45:03.498428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.869013ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-ks-endpoints\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-21T21:45:03.498529Z","caller":"traceutil/trace.go:171","msg":"trace[1928712265] range","detail":"{range_begin:/registry/jobs/openstack/manila-ks-endpoints; range_end:; response_count:0; response_revision:25589; }","duration":"110.021255ms","start":"2026-07-21T21:45:03.388485Z","end":"2026-07-21T21:45:03.498506Z","steps":["trace[1928712265] 'agreement among raft nodes before linearized reading' (duration: 109.848521ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:45:15.570384Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-000000000000679d.wal"} {"level":"info","ts":"2026-07-21T21:45:22.966753Z","caller":"traceutil/trace.go:171","msg":"trace[831966389] transaction","detail":"{read_only:false; response_revision:25782; number_of_response:1; }","duration":"183.29196ms","start":"2026-07-21T21:45:22.783432Z","end":"2026-07-21T21:45:22.966724Z","steps":["trace[831966389] 'process raft request' (duration: 183.088596ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:45:22.96712Z","caller":"traceutil/trace.go:171","msg":"trace[1819955002] linearizableReadLoop","detail":"{readStateIndex:26604; appliedIndex:26604; }","duration":"139.721531ms","start":"2026-07-21T21:45:22.827383Z","end":"2026-07-21T21:45:22.967104Z","steps":["trace[1819955002] 'read index received' (duration: 139.712461ms)","trace[1819955002] 'applied index is now lower than readState.Index' (duration: 7.38µs)"],"step_count":2} {"level":"warn","ts":"2026-07-21T21:45:22.967381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.974087ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-ks-endpoints\" ","response":"range_response_count:1 size:21431"} {"level":"info","ts":"2026-07-21T21:45:22.967422Z","caller":"traceutil/trace.go:171","msg":"trace[1905967208] range","detail":"{range_begin:/registry/jobs/openstack/manila-ks-endpoints; range_end:; response_count:1; response_revision:25782; }","duration":"140.067839ms","start":"2026-07-21T21:45:22.827343Z","end":"2026-07-21T21:45:22.96741Z","steps":["trace[1905967208] 'agreement among raft nodes before linearized reading' (duration: 139.862745ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T21:45:23.012637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.133418ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-ks-user\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-21T21:45:23.012717Z","caller":"traceutil/trace.go:171","msg":"trace[1358879703] range","detail":"{range_begin:/registry/jobs/openstack/manila-ks-user; range_end:; response_count:0; response_revision:25786; }","duration":"185.272171ms","start":"2026-07-21T21:45:22.827426Z","end":"2026-07-21T21:45:23.012698Z","steps":["trace[1358879703] 'agreement among raft nodes before linearized reading' (duration: 185.134058ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:45:23.013177Z","caller":"traceutil/trace.go:171","msg":"trace[1587683323] transaction","detail":"{read_only:false; response_revision:25783; number_of_response:1; }","duration":"148.920049ms","start":"2026-07-21T21:45:22.864242Z","end":"2026-07-21T21:45:23.013162Z","steps":["trace[1587683323] 'process raft request' (duration: 110.319071ms)","trace[1587683323] 'compare' (duration: 37.379523ms)"],"step_count":2} {"level":"info","ts":"2026-07-21T21:45:23.013331Z","caller":"traceutil/trace.go:171","msg":"trace[218118764] transaction","detail":"{read_only:false; response_revision:25784; number_of_response:1; }","duration":"140.068558ms","start":"2026-07-21T21:45:22.873248Z","end":"2026-07-21T21:45:23.013317Z","steps":["trace[218118764] 'process raft request' (duration: 139.15738ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:45:23.013463Z","caller":"traceutil/trace.go:171","msg":"trace[1464141520] transaction","detail":"{read_only:false; response_revision:25785; number_of_response:1; }","duration":"140.099149ms","start":"2026-07-21T21:45:22.873354Z","end":"2026-07-21T21:45:23.013453Z","steps":["trace[1464141520] 'process raft request' (duration: 139.14093ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:45:23.013589Z","caller":"traceutil/trace.go:171","msg":"trace[1952545106] transaction","detail":"{read_only:false; response_revision:25786; number_of_response:1; }","duration":"140.15589ms","start":"2026-07-21T21:45:22.873424Z","end":"2026-07-21T21:45:23.01358Z","steps":["trace[1952545106] 'process raft request' (duration: 139.095639ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T21:46:52.933042Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":23706} {"level":"info","ts":"2026-07-21T21:46:53.071811Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":23706,"took":"134.76907ms","hash":742741356,"current-db-size-bytes":59244544,"current-db-size":"59 MB","current-db-size-in-use-bytes":37470208,"current-db-size-in-use":"38 MB"} {"level":"info","ts":"2026-07-21T21:46:53.07187Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":742741356,"revision":23706,"compact-revision":20458} {"level":"info","ts":"2026-07-21T21:51:52.938363Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":26682} {"level":"info","ts":"2026-07-21T21:51:53.075103Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":26682,"took":"132.52106ms","hash":3900069313,"current-db-size-bytes":59244544,"current-db-size":"59 MB","current-db-size-in-use-bytes":32452608,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-07-21T21:51:53.075181Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3900069313,"revision":26682,"compact-revision":23706} {"level":"info","ts":"2026-07-21T21:51:59.769541Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"aab6040abcf11","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-07-21T21:51:59.775246Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003} {"level":"info","ts":"2026-07-21T21:51:59.775493Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003} {"level":"info","ts":"2026-07-21T21:56:52.94421Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":29033} {"level":"info","ts":"2026-07-21T21:56:53.080983Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":29033,"took":"131.547058ms","hash":3923400419,"current-db-size-bytes":59244544,"current-db-size":"59 MB","current-db-size-in-use-bytes":30748672,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-07-21T21:56:53.081068Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3923400419,"revision":29033,"compact-revision":26682} {"level":"info","ts":"2026-07-21T22:01:52.950705Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":31255} {"level":"info","ts":"2026-07-21T22:01:53.066348Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":31255,"took":"111.510283ms","hash":2162822396,"current-db-size-bytes":59244544,"current-db-size":"59 MB","current-db-size-in-use-bytes":33566720,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-07-21T22:01:53.066414Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2162822396,"revision":31255,"compact-revision":29033} {"level":"info","ts":"2026-07-21T22:06:52.957769Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":33657} {"level":"info","ts":"2026-07-21T22:06:53.110017Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":33657,"took":"147.71721ms","hash":340334671,"current-db-size-bytes":60284928,"current-db-size":"60 MB","current-db-size-in-use-bytes":32735232,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-07-21T22:06:53.110075Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":340334671,"revision":33657,"compact-revision":31255} {"level":"info","ts":"2026-07-21T22:11:52.965114Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":35916} {"level":"info","ts":"2026-07-21T22:11:53.118306Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":35916,"took":"147.503687ms","hash":508707142,"current-db-size-bytes":60284928,"current-db-size":"60 MB","current-db-size-in-use-bytes":31518720,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-07-21T22:11:53.118384Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":508707142,"revision":35916,"compact-revision":33657}