{"level":"warn","ts":"2026-10-17T10:45:14.106304Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-17T10:45:14.106401Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.161:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://162.253.55.161:2380","--initial-cluster=instance=https://162.253.55.161:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.161:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.161: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-10-17T10:45:14.106471Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-17T10:45:14.106485Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.161:2380"]} {"level":"info","ts":"2026-10-17T10:45:14.106511Z","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-10-17T10:45:14.10724Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.161:2379"]} {"level":"info","ts":"2026-10-17T10:45:14.107329Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.161:2380"],"listen-peer-urls":["https://162.253.55.161:2380"],"advertise-client-urls":["https://162.253.55.161:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.161:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.161: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-10-17T10:45:14.111956Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.383764ms"} {"level":"info","ts":"2026-10-17T10:45:14.118493Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"383aa7db69884d67","cluster-id":"2ae15ce520a2ef1e"} {"level":"info","ts":"2026-10-17T10:45:14.118561Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"383aa7db69884d67 switched to configuration voters=()"} {"level":"info","ts":"2026-10-17T10:45:14.118581Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"383aa7db69884d67 became follower at term 0"} {"level":"info","ts":"2026-10-17T10:45:14.118593Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 383aa7db69884d67 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-17T10:45:14.118603Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"383aa7db69884d67 became follower at term 1"} {"level":"info","ts":"2026-10-17T10:45:14.118635Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"383aa7db69884d67 switched to configuration voters=(4051735375583399271)"} {"level":"warn","ts":"2026-10-17T10:45:14.126083Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-17T10:45:14.127706Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-17T10:45:14.129089Z","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-10-17T10:45:14.131221Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"383aa7db69884d67","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-17T10:45:14.131452Z","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-10-17T10:45:14.131546Z","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-10-17T10:45:14.131565Z","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-10-17T10:45:14.131873Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"383aa7db69884d67","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-17T10:45:14.133782Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"383aa7db69884d67 switched to configuration voters=(4051735375583399271)"} {"level":"info","ts":"2026-10-17T10:45:14.134014Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"2ae15ce520a2ef1e","local-member-id":"383aa7db69884d67","added-peer-id":"383aa7db69884d67","added-peer-peer-urls":["https://162.253.55.161:2380"]} {"level":"info","ts":"2026-10-17T10:45:14.136213Z","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-10-17T10:45:14.136376Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.161:2380"} {"level":"info","ts":"2026-10-17T10:45:14.136405Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.161:2380"} {"level":"info","ts":"2026-10-17T10:45:14.136693Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"383aa7db69884d67","initial-advertise-peer-urls":["https://162.253.55.161:2380"],"listen-peer-urls":["https://162.253.55.161:2380"],"advertise-client-urls":["https://162.253.55.161:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.161:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-17T10:45:14.136762Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-17T10:45:15.018854Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"383aa7db69884d67 is starting a new election at term 1"} {"level":"info","ts":"2026-10-17T10:45:15.018943Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"383aa7db69884d67 became pre-candidate at term 1"} {"level":"info","ts":"2026-10-17T10:45:15.018985Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"383aa7db69884d67 received MsgPreVoteResp from 383aa7db69884d67 at term 1"} {"level":"info","ts":"2026-10-17T10:45:15.019004Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"383aa7db69884d67 became candidate at term 2"} {"level":"info","ts":"2026-10-17T10:45:15.019014Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"383aa7db69884d67 received MsgVoteResp from 383aa7db69884d67 at term 2"} {"level":"info","ts":"2026-10-17T10:45:15.019029Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"383aa7db69884d67 became leader at term 2"} {"level":"info","ts":"2026-10-17T10:45:15.019041Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 383aa7db69884d67 elected leader 383aa7db69884d67 at term 2"} {"level":"info","ts":"2026-10-17T10:45:15.020123Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-17T10:45:15.021342Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-17T10:45:15.021351Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"383aa7db69884d67","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.161:2379]}","request-path":"/0/members/383aa7db69884d67/attributes","cluster-id":"2ae15ce520a2ef1e","publish-timeout":"7s"} {"level":"info","ts":"2026-10-17T10:45:15.021405Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-17T10:45:15.021861Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-17T10:45:15.021948Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-17T10:45:15.021942Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"2ae15ce520a2ef1e","local-member-id":"383aa7db69884d67","cluster-version":"3.5"} {"level":"info","ts":"2026-10-17T10:45:15.022151Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-17T10:45:15.022207Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-17T10:45:15.024803Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-10-17T10:45:15.024807Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.161:2379"} {"level":"warn","ts":"2026-10-17T10:45:16.740219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.316142ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-10-17T10:45:16.740318Z","caller":"traceutil/trace.go:171","msg":"trace[1360419955] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:3; }","duration":"181.473336ms","start":"2026-10-17T10:45:16.558828Z","end":"2026-10-17T10:45:16.740301Z","steps":["trace[1360419955] 'range keys from in-memory index tree' (duration: 181.21797ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:45:16.740346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.017213ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.161\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-10-17T10:45:16.740417Z","caller":"traceutil/trace.go:171","msg":"trace[1513367942] range","detail":"{range_begin:/registry/masterleases/162.253.55.161; range_end:; response_count:0; response_revision:3; }","duration":"175.112356ms","start":"2026-10-17T10:45:16.565288Z","end":"2026-10-17T10:45:16.7404Z","steps":["trace[1513367942] 'range keys from in-memory index tree' (duration: 174.965812ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:45:16.740548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.504279ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-10-17T10:45:16.74063Z","caller":"traceutil/trace.go:171","msg":"trace[194678202] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:3; }","duration":"198.608602ms","start":"2026-10-17T10:45:16.542002Z","end":"2026-10-17T10:45:16.740611Z","steps":["trace[194678202] 'range keys from in-memory index tree' (duration: 198.414747ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:45:16.740679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.9205ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-10-17T10:45:16.740784Z","caller":"traceutil/trace.go:171","msg":"trace[461273450] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:3; }","duration":"172.081883ms","start":"2026-10-17T10:45:16.568674Z","end":"2026-10-17T10:45:16.740756Z","steps":["trace[461273450] 'range keys from in-memory index tree' (duration: 171.832598ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:45:16.740875Z","caller":"traceutil/trace.go:171","msg":"trace[2128561012] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"171.240284ms","start":"2026-10-17T10:45:16.569593Z","end":"2026-10-17T10:45:16.740833Z","steps":["trace[2128561012] 'process raft request' (duration: 159.204339ms)","trace[2128561012] 'compare' (duration: 11.289387ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:45:16.747057Z","caller":"traceutil/trace.go:171","msg":"trace[1618091009] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"176.732203ms","start":"2026-10-17T10:45:16.570299Z","end":"2026-10-17T10:45:16.747031Z","steps":["trace[1618091009] 'process raft request' (duration: 176.58167ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:45:16.747108Z","caller":"traceutil/trace.go:171","msg":"trace[1689583190] linearizableReadLoop","detail":"{readStateIndex:12; appliedIndex:6; }","duration":"176.18474ms","start":"2026-10-17T10:45:16.570908Z","end":"2026-10-17T10:45:16.747092Z","steps":["trace[1689583190] 'read index received' (duration: 157.917938ms)","trace[1689583190] 'applied index is now lower than readState.Index' (duration: 18.266052ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:45:16.747174Z","caller":"traceutil/trace.go:171","msg":"trace[1303671062] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"163.772176ms","start":"2026-10-17T10:45:16.583386Z","end":"2026-10-17T10:45:16.747158Z","steps":["trace[1303671062] 'process raft request' (duration: 163.652724ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:45:16.747214Z","caller":"traceutil/trace.go:171","msg":"trace[545462342] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"176.770535ms","start":"2026-10-17T10:45:16.570435Z","end":"2026-10-17T10:45:16.747205Z","steps":["trace[545462342] 'process raft request' (duration: 176.512198ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:45:16.747283Z","caller":"traceutil/trace.go:171","msg":"trace[120984813] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"176.781374ms","start":"2026-10-17T10:45:16.570493Z","end":"2026-10-17T10:45:16.747274Z","steps":["trace[120984813] 'process raft request' (duration: 176.488207ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:45:16.747217Z","caller":"traceutil/trace.go:171","msg":"trace[1333594143] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"163.734186ms","start":"2026-10-17T10:45:16.583462Z","end":"2026-10-17T10:45:16.747196Z","steps":["trace[1333594143] 'process raft request' (duration: 163.605023ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:45:16.747134Z","caller":"traceutil/trace.go:171","msg":"trace[2040543466] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"176.505878ms","start":"2026-10-17T10:45:16.570608Z","end":"2026-10-17T10:45:16.747113Z","steps":["trace[2040543466] 'process raft request' (duration: 176.406196ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:45:16.747503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.532049ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-10-17T10:45:16.747593Z","caller":"traceutil/trace.go:171","msg":"trace[889312839] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:11; }","duration":"176.691822ms","start":"2026-10-17T10:45:16.570875Z","end":"2026-10-17T10:45:16.747567Z","steps":["trace[889312839] 'agreement among raft nodes before linearized reading' (duration: 176.395225ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:45:16.747732Z","caller":"traceutil/trace.go:171","msg":"trace[1768231255] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"176.752264ms","start":"2026-10-17T10:45:16.570555Z","end":"2026-10-17T10:45:16.747308Z","steps":["trace[1768231255] 'process raft request' (duration: 176.444587ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:45:16.750595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.734322ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-10-17T10:45:16.750731Z","caller":"traceutil/trace.go:171","msg":"trace[1469238938] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:12; }","duration":"132.904315ms","start":"2026-10-17T10:45:16.617809Z","end":"2026-10-17T10:45:16.750713Z","steps":["trace[1469238938] 'agreement among raft nodes before linearized reading' (duration: 132.68302ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:45:16.750872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.514497ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-10-17T10:45:16.750912Z","caller":"traceutil/trace.go:171","msg":"trace[1755081869] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:12; }","duration":"113.623ms","start":"2026-10-17T10:45:16.637276Z","end":"2026-10-17T10:45:16.750899Z","steps":["trace[1755081869] 'agreement among raft nodes before linearized reading' (duration: 113.569759ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:45:16.750991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.594911ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/default\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-10-17T10:45:16.751054Z","caller":"traceutil/trace.go:171","msg":"trace[1054177372] range","detail":"{range_begin:/registry/namespaces/default; range_end:; response_count:0; response_revision:12; }","duration":"119.679733ms","start":"2026-10-17T10:45:16.631363Z","end":"2026-10-17T10:45:16.751043Z","steps":["trace[1054177372] 'agreement among raft nodes before linearized reading' (duration: 119.598411ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:45:16.750967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.851441ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-10-17T10:45:16.751491Z","caller":"traceutil/trace.go:171","msg":"trace[1868120584] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:12; }","duration":"113.260761ms","start":"2026-10-17T10:45:16.638068Z","end":"2026-10-17T10:45:16.751329Z","steps":["trace[1868120584] 'agreement among raft nodes before linearized reading' (duration: 112.678387ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:45:30.614197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.397486ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/etcd-instance\" ","response":"range_response_count:1 size:5336"} {"level":"info","ts":"2026-10-17T10:45:30.614292Z","caller":"traceutil/trace.go:171","msg":"trace[1455369730] range","detail":"{range_begin:/registry/pods/kube-system/etcd-instance; range_end:; response_count:1; response_revision:408; }","duration":"206.55576ms","start":"2026-10-17T10:45:30.407717Z","end":"2026-10-17T10:45:30.614272Z","steps":["trace[1455369730] 'range keys from in-memory index tree' (duration: 206.325204ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:45:30.615106Z","caller":"traceutil/trace.go:171","msg":"trace[517561581] transaction","detail":"{read_only:false; response_revision:409; number_of_response:1; }","duration":"132.991499ms","start":"2026-10-17T10:45:30.482084Z","end":"2026-10-17T10:45:30.615075Z","steps":["trace[517561581] 'process raft request' (duration: 132.769863ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:45:30.838238Z","caller":"traceutil/trace.go:171","msg":"trace[180583690] transaction","detail":"{read_only:false; response_revision:411; number_of_response:1; }","duration":"167.101485ms","start":"2026-10-17T10:45:30.671111Z","end":"2026-10-17T10:45:30.838213Z","steps":["trace[180583690] 'process raft request' (duration: 167.054624ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:45:30.838335Z","caller":"traceutil/trace.go:171","msg":"trace[257776688] transaction","detail":"{read_only:false; response_revision:410; number_of_response:1; }","duration":"215.820719ms","start":"2026-10-17T10:45:30.622479Z","end":"2026-10-17T10:45:30.8383Z","steps":["trace[257776688] 'process raft request' (duration: 194.369331ms)","trace[257776688] 'compare' (duration: 21.182941ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:45:30.838465Z","caller":"traceutil/trace.go:171","msg":"trace[695380726] linearizableReadLoop","detail":"{readStateIndex:423; appliedIndex:422; }","duration":"205.550146ms","start":"2026-10-17T10:45:30.632858Z","end":"2026-10-17T10:45:30.838409Z","steps":["trace[695380726] 'read index received' (duration: 183.970325ms)","trace[695380726] 'applied index is now lower than readState.Index' (duration: 21.577351ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T10:45:30.838623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.748531ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-10-17T10:45:30.838674Z","caller":"traceutil/trace.go:171","msg":"trace[1335718468] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:411; }","duration":"205.848553ms","start":"2026-10-17T10:45:30.632815Z","end":"2026-10-17T10:45:30.838664Z","steps":["trace[1335718468] 'agreement among raft nodes before linearized reading' (duration: 205.71737ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:46:04.884342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.02405ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-17T10:46:04.884412Z","caller":"traceutil/trace.go:171","msg":"trace[1693875541] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:646; }","duration":"316.139903ms","start":"2026-10-17T10:46:04.568258Z","end":"2026-10-17T10:46:04.884398Z","steps":["trace[1693875541] 'range keys from in-memory index tree' (duration: 315.951999ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:46:04.88444Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:46:04.568239Z","time spent":"316.195604ms","remote":"127.0.0.1:52546","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-10-17T10:46:05.028204Z","caller":"traceutil/trace.go:171","msg":"trace[411581578] transaction","detail":"{read_only:false; response_revision:647; number_of_response:1; }","duration":"172.535095ms","start":"2026-10-17T10:46:04.855623Z","end":"2026-10-17T10:46:05.028158Z","steps":["trace[411581578] 'process raft request' (duration: 171.564461ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:46:05.553017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"416.995437ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-17T10:46:05.553266Z","caller":"traceutil/trace.go:171","msg":"trace[1957110859] transaction","detail":"{read_only:false; response_revision:649; number_of_response:1; }","duration":"451.138457ms","start":"2026-10-17T10:46:05.102105Z","end":"2026-10-17T10:46:05.553243Z","steps":["trace[1957110859] 'process raft request' (duration: 451.065126ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:46:05.55327Z","caller":"traceutil/trace.go:171","msg":"trace[1274889360] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"500.101944ms","start":"2026-10-17T10:46:05.053119Z","end":"2026-10-17T10:46:05.553221Z","steps":["trace[1274889360] 'process raft request' (duration: 81.967669ms)","trace[1274889360] 'compare' (duration: 416.759342ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T10:46:05.553347Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:46:05.102068Z","time spent":"451.24843ms","remote":"127.0.0.1:53088","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-17T10:46:05.553432Z","caller":"traceutil/trace.go:171","msg":"trace[961749578] linearizableReadLoop","detail":"{readStateIndex:672; appliedIndex:671; }","duration":"478.882704ms","start":"2026-10-17T10:46:05.074391Z","end":"2026-10-17T10:46:05.553273Z","steps":["trace[961749578] 'read index received' (duration: 60.717789ms)","trace[961749578] 'applied index is now lower than readState.Index' (duration: 418.161805ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T10:46:05.553475Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:46:05.053099Z","time spent":"500.263057ms","remote":"127.0.0.1:52838","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-17T10:46:05.553688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"479.313734ms","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-10-17T10:46:05.553733Z","caller":"traceutil/trace.go:171","msg":"trace[626203067] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:649; }","duration":"479.404297ms","start":"2026-10-17T10:46:05.074315Z","end":"2026-10-17T10:46:05.55372Z","steps":["trace[626203067] 'agreement among raft nodes before linearized reading' (duration: 479.206432ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:46:05.553765Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:46:05.074285Z","time spent":"479.473068ms","remote":"127.0.0.1:52838","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-10-17T10:46:05.553805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"446.885516ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-10-17T10:46:05.553851Z","caller":"traceutil/trace.go:171","msg":"trace[913656407] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:649; }","duration":"446.975008ms","start":"2026-10-17T10:46:05.106863Z","end":"2026-10-17T10:46:05.553838Z","steps":["trace[913656407] 'agreement among raft nodes before linearized reading' (duration: 446.800353ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:46:05.553884Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:46:05.106837Z","time spent":"447.040099ms","remote":"127.0.0.1:52838","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-10-17T10:46:05.554116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.972753ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-10-17T10:46:05.554221Z","caller":"traceutil/trace.go:171","msg":"trace[182023710] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:649; }","duration":"195.170858ms","start":"2026-10-17T10:46:05.359033Z","end":"2026-10-17T10:46:05.554204Z","steps":["trace[182023710] 'agreement among raft nodes before linearized reading' (duration: 194.782609ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:46:05.739182Z","caller":"traceutil/trace.go:171","msg":"trace[1458423230] linearizableReadLoop","detail":"{readStateIndex:676; appliedIndex:673; }","duration":"170.26948ms","start":"2026-10-17T10:46:05.568878Z","end":"2026-10-17T10:46:05.739148Z","steps":["trace[1458423230] 'read index received' (duration: 152.970545ms)","trace[1458423230] 'applied index is now lower than readState.Index' (duration: 17.297475ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:46:05.739365Z","caller":"traceutil/trace.go:171","msg":"trace[1459471049] transaction","detail":"{read_only:false; response_revision:652; number_of_response:1; }","duration":"179.734147ms","start":"2026-10-17T10:46:05.559617Z","end":"2026-10-17T10:46:05.739352Z","steps":["trace[1459471049] 'process raft request' (duration: 179.480591ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:46:05.739339Z","caller":"traceutil/trace.go:171","msg":"trace[1448377626] transaction","detail":"{read_only:false; response_revision:651; number_of_response:1; }","duration":"180.469555ms","start":"2026-10-17T10:46:05.558827Z","end":"2026-10-17T10:46:05.739297Z","steps":["trace[1448377626] 'process raft request' (duration: 180.202168ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:46:05.739513Z","caller":"traceutil/trace.go:171","msg":"trace[82699926] transaction","detail":"{read_only:false; response_revision:650; number_of_response:1; }","duration":"180.654299ms","start":"2026-10-17T10:46:05.558828Z","end":"2026-10-17T10:46:05.739482Z","steps":["trace[82699926] 'process raft request' (duration: 163.006625ms)","trace[82699926] 'compare' (duration: 16.968168ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T10:46:05.739527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.540007ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-17T10:46:05.739683Z","caller":"traceutil/trace.go:171","msg":"trace[138638837] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:652; }","duration":"170.675ms","start":"2026-10-17T10:46:05.568949Z","end":"2026-10-17T10:46:05.739624Z","steps":["trace[138638837] 'agreement among raft nodes before linearized reading' (duration: 170.526216ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:46:05.73969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.811303ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-17T10:46:05.739785Z","caller":"traceutil/trace.go:171","msg":"trace[491891140] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:652; }","duration":"170.944736ms","start":"2026-10-17T10:46:05.568825Z","end":"2026-10-17T10:46:05.73977Z","steps":["trace[491891140] 'agreement among raft nodes before linearized reading' (duration: 170.739181ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:46:21.808747Z","caller":"traceutil/trace.go:171","msg":"trace[17867494] linearizableReadLoop","detail":"{readStateIndex:837; appliedIndex:836; }","duration":"174.721487ms","start":"2026-10-17T10:46:21.634002Z","end":"2026-10-17T10:46:21.808723Z","steps":["trace[17867494] 'read index received' (duration: 174.564713ms)","trace[17867494] 'applied index is now lower than readState.Index' (duration: 155.264µs)"],"step_count":2} {"level":"warn","ts":"2026-10-17T10:46:21.808997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.970773ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-10-17T10:46:21.809038Z","caller":"traceutil/trace.go:171","msg":"trace[2110136619] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:808; }","duration":"175.052695ms","start":"2026-10-17T10:46:21.633974Z","end":"2026-10-17T10:46:21.809026Z","steps":["trace[2110136619] 'agreement among raft nodes before linearized reading' (duration: 174.85612ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:46:21.809097Z","caller":"traceutil/trace.go:171","msg":"trace[1788909215] transaction","detail":"{read_only:false; response_revision:808; number_of_response:1; }","duration":"205.050316ms","start":"2026-10-17T10:46:21.603957Z","end":"2026-10-17T10:46:21.809008Z","steps":["trace[1788909215] 'process raft request' (duration: 204.566664ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:46:21.883777Z","caller":"traceutil/trace.go:171","msg":"trace[1235320284] transaction","detail":"{read_only:false; response_revision:809; number_of_response:1; }","duration":"138.191279ms","start":"2026-10-17T10:46:21.745561Z","end":"2026-10-17T10:46:21.883752Z","steps":["trace[1235320284] 'process raft request' (duration: 138.039526ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:47:37.228273Z","caller":"traceutil/trace.go:171","msg":"trace[783624501] linearizableReadLoop","detail":"{readStateIndex:1949; appliedIndex:1948; }","duration":"201.826633ms","start":"2026-10-17T10:47:37.026416Z","end":"2026-10-17T10:47:37.228242Z","steps":["trace[783624501] 'read index received' (duration: 201.683669ms)","trace[783624501] 'applied index is now lower than readState.Index' (duration: 141.174µs)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:47:37.228425Z","caller":"traceutil/trace.go:171","msg":"trace[1128718043] transaction","detail":"{read_only:false; response_revision:1876; number_of_response:1; }","duration":"431.91186ms","start":"2026-10-17T10:47:36.796484Z","end":"2026-10-17T10:47:37.228396Z","steps":["trace[1128718043] 'process raft request' (duration: 431.513591ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:47:37.228587Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:47:36.796462Z","time spent":"432.018232ms","remote":"127.0.0.1:52838","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-17T10:47:37.228598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.180791ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-fa1f321e-a82e-44ee-a6bf-d558b5dfaacb\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-10-17T10:47:37.228694Z","caller":"traceutil/trace.go:171","msg":"trace[1658935368] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-fa1f321e-a82e-44ee-a6bf-d558b5dfaacb; range_end:; response_count:1; response_revision:1876; }","duration":"202.282203ms","start":"2026-10-17T10:47:37.026362Z","end":"2026-10-17T10:47:37.228644Z","steps":["trace[1658935368] 'agreement among raft nodes before linearized reading' (duration: 202.082469ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:47:37.285939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.207384ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-17T10:47:37.285944Z","caller":"traceutil/trace.go:171","msg":"trace[705374818] transaction","detail":"{read_only:false; response_revision:1877; number_of_response:1; }","duration":"218.185944ms","start":"2026-10-17T10:47:37.067724Z","end":"2026-10-17T10:47:37.28591Z","steps":["trace[705374818] 'process raft request' (duration: 218.00849ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:47:37.286002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.782015ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-17T10:47:37.286012Z","caller":"traceutil/trace.go:171","msg":"trace[400540309] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1877; }","duration":"218.363938ms","start":"2026-10-17T10:47:37.06763Z","end":"2026-10-17T10:47:37.285994Z","steps":["trace[400540309] 'agreement among raft nodes before linearized reading' (duration: 218.230945ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:47:37.286055Z","caller":"traceutil/trace.go:171","msg":"trace[38185763] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:1877; }","duration":"143.849097ms","start":"2026-10-17T10:47:37.142191Z","end":"2026-10-17T10:47:37.286041Z","steps":["trace[38185763] 'agreement among raft nodes before linearized reading' (duration: 143.749305ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:47:37.390426Z","caller":"traceutil/trace.go:171","msg":"trace[1679926483] transaction","detail":"{read_only:false; response_revision:1878; number_of_response:1; }","duration":"153.022427ms","start":"2026-10-17T10:47:37.237384Z","end":"2026-10-17T10:47:37.390406Z","steps":["trace[1679926483] 'process raft request' (duration: 152.835312ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:47:53.471544Z","caller":"traceutil/trace.go:171","msg":"trace[19268204] linearizableReadLoop","detail":"{readStateIndex:2086; appliedIndex:2085; }","duration":"119.619928ms","start":"2026-10-17T10:47:53.351898Z","end":"2026-10-17T10:47:53.471518Z","steps":["trace[19268204] 'read index received' (duration: 119.443284ms)","trace[19268204] 'applied index is now lower than readState.Index' (duration: 175.094µs)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:47:53.471649Z","caller":"traceutil/trace.go:171","msg":"trace[2060286572] transaction","detail":"{read_only:false; response_revision:2009; number_of_response:1; }","duration":"135.625541ms","start":"2026-10-17T10:47:53.335992Z","end":"2026-10-17T10:47:53.471618Z","steps":["trace[2060286572] 'process raft request' (duration: 135.325184ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:47:53.471786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.878124ms","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-10-17T10:47:53.471833Z","caller":"traceutil/trace.go:171","msg":"trace[514071090] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2009; }","duration":"119.983997ms","start":"2026-10-17T10:47:53.351834Z","end":"2026-10-17T10:47:53.471818Z","steps":["trace[514071090] 'agreement among raft nodes before linearized reading' (duration: 119.785862ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:48:26.745162Z","caller":"traceutil/trace.go:171","msg":"trace[1942335755] transaction","detail":"{read_only:false; response_revision:2193; number_of_response:1; }","duration":"180.98666ms","start":"2026-10-17T10:48:26.564145Z","end":"2026-10-17T10:48:26.745132Z","steps":["trace[1942335755] 'process raft request' (duration: 156.871777ms)","trace[1942335755] 'compare' (duration: 23.918118ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:48:26.74541Z","caller":"traceutil/trace.go:171","msg":"trace[1488656710] linearizableReadLoop","detail":"{readStateIndex:2277; appliedIndex:2275; }","duration":"179.348711ms","start":"2026-10-17T10:48:26.566027Z","end":"2026-10-17T10:48:26.745375Z","steps":["trace[1488656710] 'read index received' (duration: 22.251309ms)","trace[1488656710] 'applied index is now lower than readState.Index' (duration: 157.094602ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:48:26.745517Z","caller":"traceutil/trace.go:171","msg":"trace[1109886136] transaction","detail":"{read_only:false; response_revision:2194; number_of_response:1; }","duration":"178.617694ms","start":"2026-10-17T10:48:26.566858Z","end":"2026-10-17T10:48:26.745475Z","steps":["trace[1109886136] 'process raft request' (duration: 178.228485ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:48:26.745651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.748529ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-17T10:48:26.745748Z","caller":"traceutil/trace.go:171","msg":"trace[1434812715] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2194; }","duration":"176.885993ms","start":"2026-10-17T10:48:26.568843Z","end":"2026-10-17T10:48:26.745729Z","steps":["trace[1434812715] 'agreement among raft nodes before linearized reading' (duration: 176.726679ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:48:26.745752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.72017ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-10-17T10:48:26.745838Z","caller":"traceutil/trace.go:171","msg":"trace[788183592] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2194; }","duration":"179.805602ms","start":"2026-10-17T10:48:26.566011Z","end":"2026-10-17T10:48:26.745817Z","steps":["trace[788183592] 'agreement among raft nodes before linearized reading' (duration: 179.532685ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:49:41.076469Z","caller":"traceutil/trace.go:171","msg":"trace[115786137] transaction","detail":"{read_only:false; response_revision:2792; number_of_response:1; }","duration":"125.488545ms","start":"2026-10-17T10:49:40.950951Z","end":"2026-10-17T10:49:41.07644Z","steps":["trace[115786137] 'process raft request' (duration: 125.310311ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:49:41.340523Z","caller":"traceutil/trace.go:171","msg":"trace[943405656] transaction","detail":"{read_only:false; response_revision:2793; number_of_response:1; }","duration":"298.961217ms","start":"2026-10-17T10:49:41.041498Z","end":"2026-10-17T10:49:41.34046Z","steps":["trace[943405656] 'process raft request' (duration: 202.751956ms)","trace[943405656] 'compare' (duration: 95.591977ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:49:41.340867Z","caller":"traceutil/trace.go:171","msg":"trace[217831763] linearizableReadLoop","detail":"{readStateIndex:2900; appliedIndex:2899; }","duration":"241.489435ms","start":"2026-10-17T10:49:41.099338Z","end":"2026-10-17T10:49:41.340828Z","steps":["trace[217831763] 'read index received' (duration: 144.830893ms)","trace[217831763] 'applied index is now lower than readState.Index' (duration: 96.656512ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T10:49:41.341116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.764931ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-10-17T10:49:41.34121Z","caller":"traceutil/trace.go:171","msg":"trace[1670386816] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2793; }","duration":"241.905804ms","start":"2026-10-17T10:49:41.09928Z","end":"2026-10-17T10:49:41.341186Z","steps":["trace[1670386816] 'agreement among raft nodes before linearized reading' (duration: 241.668859ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:49:41.341381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.562805ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-10-17T10:49:41.341435Z","caller":"traceutil/trace.go:171","msg":"trace[1345844809] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2793; }","duration":"211.669338ms","start":"2026-10-17T10:49:41.129751Z","end":"2026-10-17T10:49:41.34142Z","steps":["trace[1345844809] 'agreement among raft nodes before linearized reading' (duration: 211.34444ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:49:41.3415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.581776ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-10-17T10:49:41.341597Z","caller":"traceutil/trace.go:171","msg":"trace[189916912] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2793; }","duration":"211.788341ms","start":"2026-10-17T10:49:41.129787Z","end":"2026-10-17T10:49:41.341576Z","steps":["trace[189916912] 'agreement among raft nodes before linearized reading' (duration: 211.34794ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:54:17.825211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.899074ms","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":"warn","ts":"2026-10-17T10:54:17.825217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.366811ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"} {"level":"info","ts":"2026-10-17T10:54:17.825319Z","caller":"traceutil/trace.go:171","msg":"trace[1757066104] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:5161; }","duration":"297.523945ms","start":"2026-10-17T10:54:17.527769Z","end":"2026-10-17T10:54:17.825293Z","steps":["trace[1757066104] 'range keys from in-memory index tree' (duration: 297.141476ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:54:17.825445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.047214ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-10-17T10:54:17.825474Z","caller":"traceutil/trace.go:171","msg":"trace[579389426] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5161; }","duration":"281.114145ms","start":"2026-10-17T10:54:17.544353Z","end":"2026-10-17T10:54:17.825467Z","steps":["trace[579389426] 'range keys from in-memory index tree' (duration: 280.957152ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:54:17.825608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.075571ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-17T10:54:17.825606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.203037ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/monitoring/kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:1219"} {"level":"info","ts":"2026-10-17T10:54:17.825627Z","caller":"traceutil/trace.go:171","msg":"trace[927785833] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5161; }","duration":"256.133072ms","start":"2026-10-17T10:54:17.569489Z","end":"2026-10-17T10:54:17.825622Z","steps":["trace[927785833] 'range keys from in-memory index tree' (duration: 255.986639ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:54:17.825638Z","caller":"traceutil/trace.go:171","msg":"trace[376197161] range","detail":"{range_begin:/registry/serviceaccounts/monitoring/kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:5161; }","duration":"190.271369ms","start":"2026-10-17T10:54:17.635357Z","end":"2026-10-17T10:54:17.825628Z","steps":["trace[376197161] 'range keys from in-memory index tree' (duration: 190.090374ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:54:17.825273Z","caller":"traceutil/trace.go:171","msg":"trace[967264790] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5161; }","duration":"250.004367ms","start":"2026-10-17T10:54:17.575257Z","end":"2026-10-17T10:54:17.825262Z","steps":["trace[967264790] 'range keys from in-memory index tree' (duration: 249.74614ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:54:27.330869Z","caller":"traceutil/trace.go:171","msg":"trace[254020415] linearizableReadLoop","detail":"{readStateIndex:5558; appliedIndex:5557; }","duration":"141.09101ms","start":"2026-10-17T10:54:27.189753Z","end":"2026-10-17T10:54:27.330844Z","steps":["trace[254020415] 'read index received' (duration: 140.963487ms)","trace[254020415] 'applied index is now lower than readState.Index' (duration: 126.233µs)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:54:27.330941Z","caller":"traceutil/trace.go:171","msg":"trace[1128201205] transaction","detail":"{read_only:false; response_revision:5354; number_of_response:1; }","duration":"143.532738ms","start":"2026-10-17T10:54:27.187371Z","end":"2026-10-17T10:54:27.330904Z","steps":["trace[1128201205] 'process raft request' (duration: 143.261802ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:54:27.331788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.011023ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:57 size:2225408"} {"level":"info","ts":"2026-10-17T10:54:27.331837Z","caller":"traceutil/trace.go:171","msg":"trace[87381838] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:57; response_revision:5354; }","duration":"142.114545ms","start":"2026-10-17T10:54:27.189711Z","end":"2026-10-17T10:54:27.331825Z","steps":["trace[87381838] 'agreement among raft nodes before linearized reading' (duration: 141.239604ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:54:27.450499Z","caller":"traceutil/trace.go:171","msg":"trace[1247526889] transaction","detail":"{read_only:false; response_revision:5355; number_of_response:1; }","duration":"104.42852ms","start":"2026-10-17T10:54:27.346034Z","end":"2026-10-17T10:54:27.450463Z","steps":["trace[1247526889] 'process raft request' (duration: 36.508617ms)","trace[1247526889] 'compare' (duration: 67.618126ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:54:27.450737Z","caller":"traceutil/trace.go:171","msg":"trace[2066431571] transaction","detail":"{read_only:false; response_revision:5356; number_of_response:1; }","duration":"104.607994ms","start":"2026-10-17T10:54:27.346104Z","end":"2026-10-17T10:54:27.450712Z","steps":["trace[2066431571] 'process raft request' (duration: 104.225725ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:54:27.451076Z","caller":"traceutil/trace.go:171","msg":"trace[1522481841] transaction","detail":"{read_only:false; response_revision:5357; number_of_response:1; }","duration":"104.85784ms","start":"2026-10-17T10:54:27.346201Z","end":"2026-10-17T10:54:27.451059Z","steps":["trace[1522481841] 'process raft request' (duration: 104.211105ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:54:27.452467Z","caller":"traceutil/trace.go:171","msg":"trace[545304440] transaction","detail":"{read_only:false; response_revision:5358; number_of_response:1; }","duration":"106.266623ms","start":"2026-10-17T10:54:27.346184Z","end":"2026-10-17T10:54:27.45245Z","steps":["trace[545304440] 'process raft request' (duration: 104.469001ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:54:27.45252Z","caller":"traceutil/trace.go:171","msg":"trace[146027163] transaction","detail":"{read_only:false; response_revision:5359; number_of_response:1; }","duration":"106.198131ms","start":"2026-10-17T10:54:27.346291Z","end":"2026-10-17T10:54:27.452489Z","steps":["trace[146027163] 'process raft request' (duration: 106.083169ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:54:32.249753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.872374ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-17T10:54:32.250096Z","caller":"traceutil/trace.go:171","msg":"trace[2103295574] transaction","detail":"{read_only:false; response_revision:5438; number_of_response:1; }","duration":"263.410334ms","start":"2026-10-17T10:54:31.986496Z","end":"2026-10-17T10:54:32.249906Z","steps":["trace[2103295574] 'process raft request' (duration: 50.289944ms)","trace[2103295574] 'compare' (duration: 212.664609ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:54:41.450986Z","caller":"traceutil/trace.go:171","msg":"trace[1050633839] transaction","detail":"{read_only:false; number_of_response:1; response_revision:5638; }","duration":"104.87206ms","start":"2026-10-17T10:54:41.346082Z","end":"2026-10-17T10:54:41.450954Z","steps":["trace[1050633839] 'process raft request' (duration: 101.909149ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:54:41.451242Z","caller":"traceutil/trace.go:171","msg":"trace[450122985] linearizableReadLoop","detail":"{readStateIndex:5848; appliedIndex:5846; }","duration":"102.937624ms","start":"2026-10-17T10:54:41.348281Z","end":"2026-10-17T10:54:41.451219Z","steps":["trace[450122985] 'read index received' (duration: 5.713996ms)","trace[450122985] 'applied index is now lower than readState.Index' (duration: 97.220908ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T10:54:41.451476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.179541ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated\" ","response":"range_response_count:1 size:1343"} {"level":"info","ts":"2026-10-17T10:54:41.451542Z","caller":"traceutil/trace.go:171","msg":"trace[999793755] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated; range_end:; response_count:1; response_revision:5639; }","duration":"103.297014ms","start":"2026-10-17T10:54:41.34823Z","end":"2026-10-17T10:54:41.451527Z","steps":["trace[999793755] 'agreement among raft nodes before linearized reading' (duration: 103.082239ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:55:15.060735Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2980} {"level":"info","ts":"2026-10-17T10:55:15.139684Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2980,"took":"77.02879ms","hash":2048327427,"current-db-size-bytes":55881728,"current-db-size":"56 MB","current-db-size-in-use-bytes":32440320,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-10-17T10:55:15.139752Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2048327427,"revision":2980,"compact-revision":-1} {"level":"info","ts":"2026-10-17T11:00:15.06879Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5916} {"level":"info","ts":"2026-10-17T11:00:15.160346Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5916,"took":"89.649176ms","hash":2441592589,"current-db-size-bytes":55881728,"current-db-size":"56 MB","current-db-size-in-use-bytes":26320896,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-10-17T11:00:15.160422Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2441592589,"revision":5916,"compact-revision":2980} {"level":"info","ts":"2026-10-17T11:00:55.083813Z","caller":"traceutil/trace.go:171","msg":"trace[667411134] linearizableReadLoop","detail":"{readStateIndex:8788; appliedIndex:8787; }","duration":"117.528601ms","start":"2026-10-17T11:00:54.966259Z","end":"2026-10-17T11:00:55.083788Z","steps":["trace[667411134] 'read index received' (duration: 117.308576ms)","trace[667411134] 'applied index is now lower than readState.Index' (duration: 219.035µs)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:00:55.083877Z","caller":"traceutil/trace.go:171","msg":"trace[1092926540] transaction","detail":"{read_only:false; response_revision:8484; number_of_response:1; }","duration":"156.365706ms","start":"2026-10-17T11:00:54.927462Z","end":"2026-10-17T11:00:55.083828Z","steps":["trace[1092926540] 'process raft request' (duration: 156.169962ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:00:55.084057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.751177ms","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-10-17T11:00:55.08409Z","caller":"traceutil/trace.go:171","msg":"trace[479343671] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8484; }","duration":"117.861409ms","start":"2026-10-17T11:00:54.966219Z","end":"2026-10-17T11:00:55.08408Z","steps":["trace[479343671] 'agreement among raft nodes before linearized reading' (duration: 117.695125ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:00:56.214026Z","caller":"traceutil/trace.go:171","msg":"trace[1077757339] transaction","detail":"{read_only:false; response_revision:8489; number_of_response:1; }","duration":"131.969895ms","start":"2026-10-17T11:00:56.082003Z","end":"2026-10-17T11:00:56.213973Z","steps":["trace[1077757339] 'process raft request' (duration: 42.962834ms)","trace[1077757339] 'compare' (duration: 88.799027ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:00:56.439811Z","caller":"traceutil/trace.go:171","msg":"trace[299256983] transaction","detail":"{read_only:false; response_revision:8491; number_of_response:1; }","duration":"131.774841ms","start":"2026-10-17T11:00:56.307989Z","end":"2026-10-17T11:00:56.439764Z","steps":["trace[299256983] 'process raft request' (duration: 131.507825ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:01:25.641679Z","caller":"traceutil/trace.go:171","msg":"trace[1827425254] transaction","detail":"{read_only:false; response_revision:8702; number_of_response:1; }","duration":"366.735531ms","start":"2026-10-17T11:01:25.274896Z","end":"2026-10-17T11:01:25.641631Z","steps":["trace[1827425254] 'process raft request' (duration: 319.357472ms)","trace[1827425254] 'compare' (duration: 47.202054ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T11:01:25.642342Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:01:25.274834Z","time spent":"367.023927ms","remote":"127.0.0.1:52838","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T11:01:25.66508Z","caller":"traceutil/trace.go:171","msg":"trace[1192863700] transaction","detail":"{read_only:false; response_revision:8703; number_of_response:1; }","duration":"389.428452ms","start":"2026-10-17T11:01:25.275323Z","end":"2026-10-17T11:01:25.664751Z","steps":["trace[1192863700] 'process raft request' (duration: 389.262758ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:01:25.665271Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:01:25.275306Z","time spent":"389.886682ms","remote":"127.0.0.1:52838","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T11:01:26.675342Z","caller":"traceutil/trace.go:171","msg":"trace[1177650175] transaction","detail":"{read_only:false; response_revision:8707; number_of_response:1; }","duration":"100.209348ms","start":"2026-10-17T11:01:26.575099Z","end":"2026-10-17T11:01:26.675308Z","steps":["trace[1177650175] 'process raft request' (duration: 43.005434ms)","trace[1177650175] 'compare' (duration: 57.04735ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:01:32.357753Z","caller":"traceutil/trace.go:171","msg":"trace[1181395398] linearizableReadLoop","detail":"{readStateIndex:9054; appliedIndex:9053; }","duration":"129.353193ms","start":"2026-10-17T11:01:32.228367Z","end":"2026-10-17T11:01:32.35772Z","steps":["trace[1181395398] 'read index received' (duration: 129.019416ms)","trace[1181395398] 'applied index is now lower than readState.Index' (duration: 332.517µs)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:01:32.357796Z","caller":"traceutil/trace.go:171","msg":"trace[958196505] transaction","detail":"{read_only:false; response_revision:8741; number_of_response:1; }","duration":"153.496869ms","start":"2026-10-17T11:01:32.204266Z","end":"2026-10-17T11:01:32.357763Z","steps":["trace[958196505] 'process raft request' (duration: 153.231892ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:01:32.357973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.572539ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-17T11:01:32.358017Z","caller":"traceutil/trace.go:171","msg":"trace[1010679802] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:8741; }","duration":"129.67534ms","start":"2026-10-17T11:01:32.22833Z","end":"2026-10-17T11:01:32.358006Z","steps":["trace[1010679802] 'agreement among raft nodes before linearized reading' (duration: 129.516437ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:01:32.983077Z","caller":"traceutil/trace.go:171","msg":"trace[884816372] transaction","detail":"{read_only:false; response_revision:8745; number_of_response:1; }","duration":"235.768319ms","start":"2026-10-17T11:01:32.747261Z","end":"2026-10-17T11:01:32.983029Z","steps":["trace[884816372] 'process raft request' (duration: 235.521334ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:01:40.143789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.441876ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:4748"} {"level":"info","ts":"2026-10-17T11:01:40.14391Z","caller":"traceutil/trace.go:171","msg":"trace[256570982] transaction","detail":"{read_only:false; number_of_response:1; response_revision:8817; }","duration":"220.668429ms","start":"2026-10-17T11:01:39.923209Z","end":"2026-10-17T11:01:40.143877Z","steps":["trace[256570982] 'process raft request' (duration: 88.064379ms)","trace[256570982] 'compare' (duration: 132.365104ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:01:40.143995Z","caller":"traceutil/trace.go:171","msg":"trace[1661005501] linearizableReadLoop","detail":"{readStateIndex:9136; appliedIndex:9134; }","duration":"220.605848ms","start":"2026-10-17T11:01:39.923359Z","end":"2026-10-17T11:01:40.143965Z","steps":["trace[1661005501] 'read index received' (duration: 4.958139ms)","trace[1661005501] 'applied index is now lower than readState.Index' (duration: 215.644739ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T11:01:40.144356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.981277ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rook-ceph-detect-version\" ","response":"range_response_count:1 size:531"} {"level":"info","ts":"2026-10-17T11:01:40.144398Z","caller":"traceutil/trace.go:171","msg":"trace[973703784] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-detect-version; range_end:; response_count:1; response_revision:8818; }","duration":"221.059838ms","start":"2026-10-17T11:01:39.923326Z","end":"2026-10-17T11:01:40.144385Z","steps":["trace[973703784] 'agreement among raft nodes before linearized reading' (duration: 220.819092ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:01:41.022492Z","caller":"traceutil/trace.go:171","msg":"trace[794839271] transaction","detail":"{read_only:false; response_revision:8826; number_of_response:1; }","duration":"263.244064ms","start":"2026-10-17T11:01:40.759221Z","end":"2026-10-17T11:01:41.022465Z","steps":["trace[794839271] 'process raft request' (duration: 263.08394ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:01:41.079461Z","caller":"traceutil/trace.go:171","msg":"trace[650481596] linearizableReadLoop","detail":"{readStateIndex:9147; appliedIndex:9144; }","duration":"229.571182ms","start":"2026-10-17T11:01:40.849861Z","end":"2026-10-17T11:01:41.079433Z","steps":["trace[650481596] 'read index received' (duration: 172.45192ms)","trace[650481596] 'applied index is now lower than readState.Index' (duration: 57.118372ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:01:41.079589Z","caller":"traceutil/trace.go:171","msg":"trace[801889681] transaction","detail":"{read_only:false; response_revision:8828; number_of_response:1; }","duration":"229.786627ms","start":"2026-10-17T11:01:40.849773Z","end":"2026-10-17T11:01:41.07956Z","steps":["trace[801889681] 'process raft request' (duration: 229.546121ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:01:41.079812Z","caller":"traceutil/trace.go:171","msg":"trace[895822793] transaction","detail":"{read_only:false; response_revision:8829; number_of_response:1; }","duration":"202.730232ms","start":"2026-10-17T11:01:40.877067Z","end":"2026-10-17T11:01:41.079797Z","steps":["trace[895822793] 'process raft request' (duration: 202.322083ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:01:41.079979Z","caller":"traceutil/trace.go:171","msg":"trace[988600431] transaction","detail":"{read_only:false; response_revision:8827; number_of_response:1; }","duration":"308.599035ms","start":"2026-10-17T11:01:40.771362Z","end":"2026-10-17T11:01:41.079961Z","steps":["trace[988600431] 'process raft request' (duration: 307.631502ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:01:41.080156Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:01:40.771332Z","time spent":"308.691727ms","remote":"127.0.0.1:52838","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-17T11:01:41.080165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.287719ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-xwv9s\" ","response":"range_response_count:1 size:4749"} {"level":"info","ts":"2026-10-17T11:01:41.080382Z","caller":"traceutil/trace.go:171","msg":"trace[1144975521] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-xwv9s; range_end:; response_count:1; response_revision:8829; }","duration":"230.563375ms","start":"2026-10-17T11:01:40.849806Z","end":"2026-10-17T11:01:41.08037Z","steps":["trace[1144975521] 'agreement among raft nodes before linearized reading' (duration: 230.185206ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:01:41.192588Z","caller":"traceutil/trace.go:171","msg":"trace[727519287] transaction","detail":"{read_only:false; response_revision:8831; number_of_response:1; }","duration":"106.799845ms","start":"2026-10-17T11:01:41.085773Z","end":"2026-10-17T11:01:41.192573Z","steps":["trace[727519287] 'process raft request' (duration: 106.57503ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:01:41.192484Z","caller":"traceutil/trace.go:171","msg":"trace[1867494992] transaction","detail":"{read_only:false; response_revision:8830; number_of_response:1; }","duration":"107.452981ms","start":"2026-10-17T11:01:41.084972Z","end":"2026-10-17T11:01:41.192425Z","steps":["trace[1867494992] 'process raft request' (duration: 81.258286ms)","trace[1867494992] 'compare' (duration: 25.949489ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:01:53.733303Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002434.wal"} {"level":"info","ts":"2026-10-17T11:03:08.998237Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"383aa7db69884d67","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-17T11:03:09.004968Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-10-17T11:03:09.005061Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-10-17T11:05:15.075305Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8098} {"level":"info","ts":"2026-10-17T11:05:15.145881Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8098,"took":"68.493953ms","hash":1195077506,"current-db-size-bytes":55881728,"current-db-size":"56 MB","current-db-size-in-use-bytes":29331456,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-10-17T11:05:15.145952Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1195077506,"revision":8098,"compact-revision":5916} {"level":"info","ts":"2026-10-17T11:06:39.759916Z","caller":"traceutil/trace.go:171","msg":"trace[1397792172] transaction","detail":"{read_only:false; response_revision:11406; number_of_response:1; }","duration":"166.767333ms","start":"2026-10-17T11:06:39.59311Z","end":"2026-10-17T11:06:39.759878Z","steps":["trace[1397792172] 'process raft request' (duration: 166.543508ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:10:15.086614Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10607} {"level":"info","ts":"2026-10-17T11:10:15.178091Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10607,"took":"88.852394ms","hash":3248298181,"current-db-size-bytes":55881728,"current-db-size":"56 MB","current-db-size-in-use-bytes":27242496,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-10-17T11:10:15.178177Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3248298181,"revision":10607,"compact-revision":8098} {"level":"info","ts":"2026-10-17T11:13:13.318612Z","caller":"traceutil/trace.go:171","msg":"trace[304582819] linearizableReadLoop","detail":"{readStateIndex:14533; appliedIndex:14532; }","duration":"186.715245ms","start":"2026-10-17T11:13:13.131873Z","end":"2026-10-17T11:13:13.318588Z","steps":["trace[304582819] 'read index received' (duration: 186.605022ms)","trace[304582819] 'applied index is now lower than readState.Index' (duration: 109.203µs)"],"step_count":2} {"level":"warn","ts":"2026-10-17T11:13:13.318779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.884239ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-17T11:13:13.318813Z","caller":"traceutil/trace.go:171","msg":"trace[759075438] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:14043; }","duration":"186.93583ms","start":"2026-10-17T11:13:13.131865Z","end":"2026-10-17T11:13:13.318801Z","steps":["trace[759075438] 'agreement among raft nodes before linearized reading' (duration: 186.822757ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:13:13.319128Z","caller":"traceutil/trace.go:171","msg":"trace[2042859285] transaction","detail":"{read_only:false; response_revision:14043; number_of_response:1; }","duration":"255.209556ms","start":"2026-10-17T11:13:13.063908Z","end":"2026-10-17T11:13:13.319117Z","steps":["trace[2042859285] 'process raft request' (duration: 254.54209ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:13:13.661742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.744094ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-17T11:13:13.661874Z","caller":"traceutil/trace.go:171","msg":"trace[1578137207] transaction","detail":"{read_only:false; response_revision:14045; number_of_response:1; }","duration":"293.007945ms","start":"2026-10-17T11:13:13.368842Z","end":"2026-10-17T11:13:13.66185Z","steps":["trace[1578137207] 'process raft request' (duration: 46.025005ms)","trace[1578137207] 'compare' (duration: 246.630732ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:13:13.716677Z","caller":"traceutil/trace.go:171","msg":"trace[998076175] transaction","detail":"{read_only:false; response_revision:14046; number_of_response:1; }","duration":"347.804999ms","start":"2026-10-17T11:13:13.368857Z","end":"2026-10-17T11:13:13.716662Z","steps":["trace[998076175] 'process raft request' (duration: 347.677076ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:13:13.716792Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:13:13.368833Z","time spent":"347.910762ms","remote":"127.0.0.1:52838","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-17T11:13:13.716975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.754877ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-17T11:13:13.717075Z","caller":"traceutil/trace.go:171","msg":"trace[1514378625] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:14046; }","duration":"147.906311ms","start":"2026-10-17T11:13:13.569144Z","end":"2026-10-17T11:13:13.717051Z","steps":["trace[1514378625] 'agreement among raft nodes before linearized reading' (duration: 147.696286ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:13:13.717236Z","caller":"traceutil/trace.go:171","msg":"trace[84605425] linearizableReadLoop","detail":"{readStateIndex:14536; appliedIndex:14535; }","duration":"147.42328ms","start":"2026-10-17T11:13:13.569199Z","end":"2026-10-17T11:13:13.716622Z","steps":["trace[84605425] 'read index received' (duration: 147.317017ms)","trace[84605425] 'applied index is now lower than readState.Index' (duration: 104.913µs)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:13:13.905164Z","caller":"traceutil/trace.go:171","msg":"trace[354478442] linearizableReadLoop","detail":"{readStateIndex:14538; appliedIndex:14536; }","duration":"187.811311ms","start":"2026-10-17T11:13:13.717333Z","end":"2026-10-17T11:13:13.905144Z","steps":["trace[354478442] 'read index received' (duration: 152.439499ms)","trace[354478442] 'applied index is now lower than readState.Index' (duration: 35.370802ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:13:13.905195Z","caller":"traceutil/trace.go:171","msg":"trace[35851697] transaction","detail":"{read_only:false; response_revision:14047; number_of_response:1; }","duration":"226.348929ms","start":"2026-10-17T11:13:13.678815Z","end":"2026-10-17T11:13:13.905164Z","steps":["trace[35851697] 'process raft request' (duration: 226.186995ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:13:13.905406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.189487ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-17T11:13:13.905593Z","caller":"traceutil/trace.go:171","msg":"trace[720077080] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:14048; }","duration":"187.415372ms","start":"2026-10-17T11:13:13.71815Z","end":"2026-10-17T11:13:13.905566Z","steps":["trace[720077080] 'agreement among raft nodes before linearized reading' (duration: 187.172617ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:13:13.905959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.035682ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/openstack/\" range_end:\"/registry/secrets/openstack0\" ","response":"range_response_count:86 size:931146"} {"level":"info","ts":"2026-10-17T11:13:13.906007Z","caller":"traceutil/trace.go:171","msg":"trace[1923366205] range","detail":"{range_begin:/registry/secrets/openstack/; range_end:/registry/secrets/openstack0; response_count:86; response_revision:14048; }","duration":"255.138435ms","start":"2026-10-17T11:13:13.650856Z","end":"2026-10-17T11:13:13.905994Z","steps":["trace[1923366205] 'agreement among raft nodes before linearized reading' (duration: 254.409487ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:14:52.796888Z","caller":"traceutil/trace.go:171","msg":"trace[637696653] transaction","detail":"{read_only:false; response_revision:15240; number_of_response:1; }","duration":"103.76628ms","start":"2026-10-17T11:14:52.693099Z","end":"2026-10-17T11:14:52.796865Z","steps":["trace[637696653] 'process raft request' (duration: 103.34943ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:14:52.987949Z","caller":"traceutil/trace.go:171","msg":"trace[1358146479] transaction","detail":"{read_only:false; response_revision:15241; number_of_response:1; }","duration":"186.560732ms","start":"2026-10-17T11:14:52.801371Z","end":"2026-10-17T11:14:52.987932Z","steps":["trace[1358146479] 'process raft request' (duration: 186.457239ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:14:52.988793Z","caller":"traceutil/trace.go:171","msg":"trace[829439953] linearizableReadLoop","detail":"{readStateIndex:15769; appliedIndex:15769; }","duration":"139.529052ms","start":"2026-10-17T11:14:52.849232Z","end":"2026-10-17T11:14:52.988761Z","steps":["trace[829439953] 'read index received' (duration: 139.519421ms)","trace[829439953] 'applied index is now lower than readState.Index' (duration: 7.801µs)"],"step_count":2} {"level":"warn","ts":"2026-10-17T11:14:52.988955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.658005ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-17T11:14:52.988956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.710087ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/neutron-server\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-17T11:14:52.988988Z","caller":"traceutil/trace.go:171","msg":"trace[1030221398] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:15241; }","duration":"139.740247ms","start":"2026-10-17T11:14:52.849236Z","end":"2026-10-17T11:14:52.988976Z","steps":["trace[1030221398] 'agreement among raft nodes before linearized reading' (duration: 139.677105ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:14:52.989015Z","caller":"traceutil/trace.go:171","msg":"trace[88536707] range","detail":"{range_begin:/registry/services/endpoints/openstack/neutron-server; range_end:; response_count:0; response_revision:15241; }","duration":"139.840789ms","start":"2026-10-17T11:14:52.849157Z","end":"2026-10-17T11:14:52.988998Z","steps":["trace[88536707] 'agreement among raft nodes before linearized reading' (duration: 139.713906ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:14:52.9892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.272721ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:668"} {"level":"info","ts":"2026-10-17T11:14:52.989254Z","caller":"traceutil/trace.go:171","msg":"trace[1683681365] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:15241; }","duration":"138.335433ms","start":"2026-10-17T11:14:52.850901Z","end":"2026-10-17T11:14:52.989236Z","steps":["trace[1683681365] 'agreement among raft nodes before linearized reading' (duration: 138.173999ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:14:52.989305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.505191ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-metadata\" ","response":"range_response_count:1 size:681"} {"level":"info","ts":"2026-10-17T11:14:52.989335Z","caller":"traceutil/trace.go:171","msg":"trace[362010676] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-metadata; range_end:; response_count:1; response_revision:15241; }","duration":"139.574783ms","start":"2026-10-17T11:14:52.849751Z","end":"2026-10-17T11:14:52.989326Z","steps":["trace[362010676] 'agreement among raft nodes before linearized reading' (duration: 139.45888ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:14:52.989468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.201571ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5523"} {"level":"info","ts":"2026-10-17T11:14:52.989515Z","caller":"traceutil/trace.go:171","msg":"trace[314994523] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:15241; }","duration":"133.263943ms","start":"2026-10-17T11:14:52.856236Z","end":"2026-10-17T11:14:52.9895Z","steps":["trace[314994523] 'agreement among raft nodes before linearized reading' (duration: 133.13402ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:14:53.266124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.631381ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-17T11:14:53.266252Z","caller":"traceutil/trace.go:171","msg":"trace[403652663] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:15241; }","duration":"175.818025ms","start":"2026-10-17T11:14:53.09041Z","end":"2026-10-17T11:14:53.266228Z","steps":["trace[403652663] 'range keys from in-memory index tree' (duration: 175.549319ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:15:15.09297Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12784} {"level":"info","ts":"2026-10-17T11:15:15.183209Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12784,"took":"84.575874ms","hash":408744363,"current-db-size-bytes":55881728,"current-db-size":"56 MB","current-db-size-in-use-bytes":30486528,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-10-17T11:15:15.183285Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":408744363,"revision":12784,"compact-revision":10607} {"level":"info","ts":"2026-10-17T11:20:15.102307Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15355} {"level":"info","ts":"2026-10-17T11:20:15.203973Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15355,"took":"98.189919ms","hash":493402803,"current-db-size-bytes":55881728,"current-db-size":"56 MB","current-db-size-in-use-bytes":32133120,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-10-17T11:20:15.204066Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":493402803,"revision":15355,"compact-revision":12784} {"level":"info","ts":"2026-10-17T11:20:39.260517Z","caller":"traceutil/trace.go:171","msg":"trace[1304519330] transaction","detail":"{read_only:false; response_revision:17854; number_of_response:1; }","duration":"359.993018ms","start":"2026-10-17T11:20:38.900499Z","end":"2026-10-17T11:20:39.260492Z","steps":["trace[1304519330] 'process raft request' (duration: 359.759363ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:20:39.260815Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:20:38.900471Z","time spent":"360.123662ms","remote":"127.0.0.1:52838","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T11:20:39.263264Z","caller":"traceutil/trace.go:171","msg":"trace[175493623] linearizableReadLoop","detail":"{readStateIndex:18469; appliedIndex:18467; }","duration":"121.300131ms","start":"2026-10-17T11:20:39.141936Z","end":"2026-10-17T11:20:39.263236Z","steps":["trace[175493623] 'read index received' (duration: 118.406172ms)","trace[175493623] 'applied index is now lower than readState.Index' (duration: 2.892539ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:20:39.263297Z","caller":"traceutil/trace.go:171","msg":"trace[1853159228] transaction","detail":"{read_only:false; response_revision:17855; number_of_response:1; }","duration":"248.947013ms","start":"2026-10-17T11:20:39.01432Z","end":"2026-10-17T11:20:39.263267Z","steps":["trace[1853159228] 'process raft request' (duration: 248.792709ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:20:39.263575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.622808ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-95nhh\" ","response":"range_response_count:1 size:9797"} {"level":"info","ts":"2026-10-17T11:20:39.263636Z","caller":"traceutil/trace.go:171","msg":"trace[311981823] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-95nhh; range_end:; response_count:1; response_revision:17855; }","duration":"121.739971ms","start":"2026-10-17T11:20:39.14188Z","end":"2026-10-17T11:20:39.26362Z","steps":["trace[311981823] 'agreement among raft nodes before linearized reading' (duration: 121.502545ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:20:39.263895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.22833ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/libvirt-libvirt-default-zqmfl\" ","response":"range_response_count:1 size:20903"} {"level":"info","ts":"2026-10-17T11:20:39.263976Z","caller":"traceutil/trace.go:171","msg":"trace[2047070081] range","detail":"{range_begin:/registry/pods/openstack/libvirt-libvirt-default-zqmfl; range_end:; response_count:1; response_revision:17855; }","duration":"103.323492ms","start":"2026-10-17T11:20:39.160629Z","end":"2026-10-17T11:20:39.263953Z","steps":["trace[2047070081] 'agreement among raft nodes before linearized reading' (duration: 103.019205ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:20:39.263988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.058005ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/prometheusrules/\" range_end:\"/registry/monitoring.coreos.com/prometheusrules0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"warn","ts":"2026-10-17T11:20:39.263873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.961578ms","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-10-17T11:20:39.264071Z","caller":"traceutil/trace.go:171","msg":"trace[878577061] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheusrules/; range_end:/registry/monitoring.coreos.com/prometheusrules0; response_count:0; response_revision:17855; }","duration":"116.122147ms","start":"2026-10-17T11:20:39.147896Z","end":"2026-10-17T11:20:39.264019Z","steps":["trace[878577061] 'agreement among raft nodes before linearized reading' (duration: 116.038345ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:20:39.26394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.750307ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-10-17T11:20:39.264166Z","caller":"traceutil/trace.go:171","msg":"trace[105313398] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:17855; }","duration":"120.331518ms","start":"2026-10-17T11:20:39.143784Z","end":"2026-10-17T11:20:39.264115Z","steps":["trace[105313398] 'agreement among raft nodes before linearized reading' (duration: 119.828556ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:20:39.264273Z","caller":"traceutil/trace.go:171","msg":"trace[362643732] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:17855; }","duration":"108.136267ms","start":"2026-10-17T11:20:39.156115Z","end":"2026-10-17T11:20:39.264251Z","steps":["trace[362643732] 'agreement among raft nodes before linearized reading' (duration: 107.707837ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:23:39.002366Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"383aa7db69884d67","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-17T11:23:39.008752Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-10-17T11:23:39.008889Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-10-17T11:25:15.111079Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17612} {"level":"info","ts":"2026-10-17T11:25:15.213921Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17612,"took":"98.763432ms","hash":3485490895,"current-db-size-bytes":55881728,"current-db-size":"56 MB","current-db-size-in-use-bytes":34238464,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-10-17T11:25:15.213989Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3485490895,"revision":17612,"compact-revision":15355} {"level":"info","ts":"2026-10-17T11:25:29.579431Z","caller":"traceutil/trace.go:171","msg":"trace[1217693281] transaction","detail":"{read_only:false; response_revision:20160; number_of_response:1; }","duration":"100.222296ms","start":"2026-10-17T11:25:29.47917Z","end":"2026-10-17T11:25:29.579392Z","steps":["trace[1217693281] 'process raft request' (duration: 99.998091ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:25:29.706693Z","caller":"traceutil/trace.go:171","msg":"trace[1217410457] transaction","detail":"{read_only:false; response_revision:20161; number_of_response:1; }","duration":"116.73425ms","start":"2026-10-17T11:25:29.589928Z","end":"2026-10-17T11:25:29.706662Z","steps":["trace[1217410457] 'process raft request' (duration: 116.247689ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:25:29.707366Z","caller":"traceutil/trace.go:171","msg":"trace[1461923665] transaction","detail":"{read_only:false; response_revision:20162; number_of_response:1; }","duration":"114.776133ms","start":"2026-10-17T11:25:29.592578Z","end":"2026-10-17T11:25:29.707354Z","steps":["trace[1461923665] 'process raft request' (duration: 114.704671ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:25:46.076776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.88459ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-17T11:25:46.076993Z","caller":"traceutil/trace.go:171","msg":"trace[838817923] transaction","detail":"{read_only:false; response_revision:20243; number_of_response:1; }","duration":"260.573006ms","start":"2026-10-17T11:25:45.816402Z","end":"2026-10-17T11:25:46.076975Z","steps":["trace[838817923] 'process raft request' (duration: 260.479574ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:25:46.07698Z","caller":"traceutil/trace.go:171","msg":"trace[1186563450] transaction","detail":"{read_only:false; response_revision:20242; number_of_response:1; }","duration":"261.331303ms","start":"2026-10-17T11:25:45.815619Z","end":"2026-10-17T11:25:46.07695Z","steps":["trace[1186563450] 'process raft request' (duration: 111.145157ms)","trace[1186563450] 'compare' (duration: 149.606252ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:25:46.440347Z","caller":"traceutil/trace.go:171","msg":"trace[2013543608] linearizableReadLoop","detail":"{readStateIndex:20936; appliedIndex:20935; }","duration":"199.361238ms","start":"2026-10-17T11:25:46.240962Z","end":"2026-10-17T11:25:46.440323Z","steps":["trace[2013543608] 'read index received' (duration: 199.203724ms)","trace[2013543608] 'applied index is now lower than readState.Index' (duration: 156.544µs)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:25:46.440597Z","caller":"traceutil/trace.go:171","msg":"trace[1337959342] transaction","detail":"{read_only:false; response_revision:20244; number_of_response:1; }","duration":"296.318597ms","start":"2026-10-17T11:25:46.144266Z","end":"2026-10-17T11:25:46.440584Z","steps":["trace[1337959342] 'process raft request' (duration: 295.907227ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:25:46.440896Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.925731ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-10-17T11:25:46.440938Z","caller":"traceutil/trace.go:171","msg":"trace[230061011] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:20244; }","duration":"200.017143ms","start":"2026-10-17T11:25:46.240908Z","end":"2026-10-17T11:25:46.440925Z","steps":["trace[230061011] 'agreement among raft nodes before linearized reading' (duration: 199.87603ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:25:46.603578Z","caller":"traceutil/trace.go:171","msg":"trace[432507656] transaction","detail":"{read_only:false; response_revision:20245; number_of_response:1; }","duration":"158.018683ms","start":"2026-10-17T11:25:46.445533Z","end":"2026-10-17T11:25:46.603552Z","steps":["trace[432507656] 'process raft request' (duration: 121.988945ms)","trace[432507656] 'compare' (duration: 35.844694ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:25:46.608382Z","caller":"traceutil/trace.go:171","msg":"trace[1009169038] transaction","detail":"{read_only:false; response_revision:20246; number_of_response:1; }","duration":"155.247537ms","start":"2026-10-17T11:25:46.453114Z","end":"2026-10-17T11:25:46.608362Z","steps":["trace[1009169038] 'process raft request' (duration: 155.028002ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:29:31.949886Z","caller":"traceutil/trace.go:171","msg":"trace[1042218710] linearizableReadLoop","detail":"{readStateIndex:23369; appliedIndex:23368; }","duration":"107.4976ms","start":"2026-10-17T11:29:31.842362Z","end":"2026-10-17T11:29:31.94986Z","steps":["trace[1042218710] 'read index received' (duration: 107.245624ms)","trace[1042218710] 'applied index is now lower than readState.Index' (duration: 251.006µs)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:29:31.950016Z","caller":"traceutil/trace.go:171","msg":"trace[1728967102] transaction","detail":"{read_only:false; response_revision:22608; number_of_response:1; }","duration":"112.213003ms","start":"2026-10-17T11:29:31.837792Z","end":"2026-10-17T11:29:31.950005Z","steps":["trace[1728967102] 'process raft request' (duration: 111.884415ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:29:31.950212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.838188ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/podmonitors/\" range_end:\"/registry/monitoring.coreos.com/podmonitors0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-10-17T11:29:31.950253Z","caller":"traceutil/trace.go:171","msg":"trace[287626667] range","detail":"{range_begin:/registry/monitoring.coreos.com/podmonitors/; range_end:/registry/monitoring.coreos.com/podmonitors0; response_count:0; response_revision:22608; }","duration":"107.9546ms","start":"2026-10-17T11:29:31.842287Z","end":"2026-10-17T11:29:31.950242Z","steps":["trace[287626667] 'agreement among raft nodes before linearized reading' (duration: 107.864668ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:29:32.192885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.540547ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"warn","ts":"2026-10-17T11:29:32.192908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.873901ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-10-17T11:29:32.192982Z","caller":"traceutil/trace.go:171","msg":"trace[248286208] transaction","detail":"{read_only:false; response_revision:22610; number_of_response:1; }","duration":"143.19784ms","start":"2026-10-17T11:29:32.04974Z","end":"2026-10-17T11:29:32.192937Z","steps":["trace[248286208] 'process raft request' (duration: 141.241403ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:29:32.193053Z","caller":"traceutil/trace.go:171","msg":"trace[1392201966] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:22609; }","duration":"174.766582ms","start":"2026-10-17T11:29:32.018256Z","end":"2026-10-17T11:29:32.193023Z","steps":["trace[1392201966] 'range keys from in-memory index tree' (duration: 174.26903ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:29:32.192948Z","caller":"traceutil/trace.go:171","msg":"trace[545504433] linearizableReadLoop","detail":"{readStateIndex:23371; appliedIndex:23370; }","duration":"134.545724ms","start":"2026-10-17T11:29:32.058361Z","end":"2026-10-17T11:29:32.192907Z","steps":["trace[545504433] 'read index received' (duration: 132.613748ms)","trace[545504433] 'applied index is now lower than readState.Index' (duration: 1.930756ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T11:29:32.19309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.726258ms","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-10-17T11:29:32.19306Z","caller":"traceutil/trace.go:171","msg":"trace[797120829] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:22609; }","duration":"169.051065ms","start":"2026-10-17T11:29:32.02399Z","end":"2026-10-17T11:29:32.193041Z","steps":["trace[797120829] 'range keys from in-memory index tree' (duration: 168.670117ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:29:32.193142Z","caller":"traceutil/trace.go:171","msg":"trace[1371142059] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:22610; }","duration":"134.83619ms","start":"2026-10-17T11:29:32.058291Z","end":"2026-10-17T11:29:32.193127Z","steps":["trace[1371142059] 'agreement among raft nodes before linearized reading' (duration: 134.698707ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:29:46.451234Z","caller":"traceutil/trace.go:171","msg":"trace[2109916631] linearizableReadLoop","detail":"{readStateIndex:23496; appliedIndex:23494; }","duration":"103.695169ms","start":"2026-10-17T11:29:46.347514Z","end":"2026-10-17T11:29:46.451209Z","steps":["trace[2109916631] 'read index received' (duration: 87.882492ms)","trace[2109916631] 'applied index is now lower than readState.Index' (duration: 15.811507ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:29:46.451366Z","caller":"traceutil/trace.go:171","msg":"trace[1530223988] transaction","detail":"{read_only:false; response_revision:22731; number_of_response:1; }","duration":"107.240983ms","start":"2026-10-17T11:29:46.344114Z","end":"2026-10-17T11:29:46.451355Z","steps":["trace[1530223988] 'process raft request' (duration: 105.485962ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:29:46.451558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.033498ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:558"} {"level":"info","ts":"2026-10-17T11:29:46.45162Z","caller":"traceutil/trace.go:171","msg":"trace[1830089462] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:22731; }","duration":"104.134599ms","start":"2026-10-17T11:29:46.347469Z","end":"2026-10-17T11:29:46.451603Z","steps":["trace[1830089462] 'agreement among raft nodes before linearized reading' (duration: 103.954385ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:30:15.119184Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":20087} {"level":"info","ts":"2026-10-17T11:30:15.236336Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":20087,"took":"113.454512ms","hash":139329647,"current-db-size-bytes":56631296,"current-db-size":"57 MB","current-db-size-in-use-bytes":42385408,"current-db-size-in-use":"42 MB"} {"level":"info","ts":"2026-10-17T11:30:15.236401Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":139329647,"revision":20087,"compact-revision":17612} {"level":"info","ts":"2026-10-17T11:32:51.070453Z","caller":"traceutil/trace.go:171","msg":"trace[28851655] transaction","detail":"{read_only:false; response_revision:24601; number_of_response:1; }","duration":"115.083841ms","start":"2026-10-17T11:32:50.955329Z","end":"2026-10-17T11:32:51.070413Z","steps":["trace[28851655] 'process raft request' (duration: 114.847916ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:32:51.319176Z","caller":"traceutil/trace.go:171","msg":"trace[1532269394] linearizableReadLoop","detail":"{readStateIndex:25414; appliedIndex:25413; }","duration":"181.062753ms","start":"2026-10-17T11:32:51.138087Z","end":"2026-10-17T11:32:51.319149Z","steps":["trace[1532269394] 'read index received' (duration: 180.894809ms)","trace[1532269394] 'applied index is now lower than readState.Index' (duration: 166.904µs)"],"step_count":2} {"level":"warn","ts":"2026-10-17T11:32:51.319309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.204186ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/machinehealthchecks/\" range_end:\"/registry/cluster.x-k8s.io/machinehealthchecks0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-17T11:32:51.319349Z","caller":"traceutil/trace.go:171","msg":"trace[2093208448] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machinehealthchecks/; range_end:/registry/cluster.x-k8s.io/machinehealthchecks0; response_count:0; response_revision:24602; }","duration":"181.306158ms","start":"2026-10-17T11:32:51.138031Z","end":"2026-10-17T11:32:51.319337Z","steps":["trace[2093208448] 'agreement among raft nodes before linearized reading' (duration: 181.215816ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:32:51.3193Z","caller":"traceutil/trace.go:171","msg":"trace[367687035] transaction","detail":"{read_only:false; response_revision:24602; number_of_response:1; }","duration":"240.786495ms","start":"2026-10-17T11:32:51.078477Z","end":"2026-10-17T11:32:51.319263Z","steps":["trace[367687035] 'process raft request' (duration: 240.512968ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:32:51.493161Z","caller":"traceutil/trace.go:171","msg":"trace[691303152] transaction","detail":"{read_only:false; response_revision:24603; number_of_response:1; }","duration":"341.462184ms","start":"2026-10-17T11:32:51.151662Z","end":"2026-10-17T11:32:51.493124Z","steps":["trace[691303152] 'process raft request' (duration: 254.500662ms)","trace[691303152] 'compare' (duration: 86.680545ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T11:32:51.493319Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:32:51.151643Z","time spent":"341.594536ms","remote":"127.0.0.1:52838","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-17T11:32:51.778273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.289924ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-17T11:32:51.778438Z","caller":"traceutil/trace.go:171","msg":"trace[1489697770] transaction","detail":"{read_only:false; response_revision:24606; number_of_response:1; }","duration":"278.515744ms","start":"2026-10-17T11:32:51.499904Z","end":"2026-10-17T11:32:51.77842Z","steps":["trace[1489697770] 'process raft request' (duration: 278.457073ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:32:51.778753Z","caller":"traceutil/trace.go:171","msg":"trace[601968837] transaction","detail":"{read_only:false; response_revision:24605; number_of_response:1; }","duration":"278.948064ms","start":"2026-10-17T11:32:51.499792Z","end":"2026-10-17T11:32:51.77874Z","steps":["trace[601968837] 'process raft request' (duration: 145.112626ms)","trace[601968837] 'compare' (duration: 133.166462ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:32:51.812343Z","caller":"traceutil/trace.go:171","msg":"trace[90467371] transaction","detail":"{read_only:false; response_revision:24607; number_of_response:1; }","duration":"256.976781ms","start":"2026-10-17T11:32:51.555338Z","end":"2026-10-17T11:32:51.812315Z","steps":["trace[90467371] 'process raft request' (duration: 256.819787ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:33:51.878445Z","caller":"traceutil/trace.go:171","msg":"trace[1114307305] transaction","detail":"{read_only:false; response_revision:25152; number_of_response:1; }","duration":"221.214688ms","start":"2026-10-17T11:33:51.657197Z","end":"2026-10-17T11:33:51.878412Z","steps":["trace[1114307305] 'process raft request' (duration: 221.054554ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:33:52.025955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.853764ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-17T11:33:52.026119Z","caller":"traceutil/trace.go:171","msg":"trace[1574043590] linearizableReadLoop","detail":"{readStateIndex:25977; appliedIndex:25975; }","duration":"176.960764ms","start":"2026-10-17T11:33:51.849082Z","end":"2026-10-17T11:33:52.026043Z","steps":["trace[1574043590] 'read index received' (duration: 29.106603ms)","trace[1574043590] 'applied index is now lower than readState.Index' (duration: 147.841031ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:33:52.027823Z","caller":"traceutil/trace.go:171","msg":"trace[2002279887] transaction","detail":"{read_only:false; response_revision:25153; number_of_response:1; }","duration":"319.510109ms","start":"2026-10-17T11:33:51.706726Z","end":"2026-10-17T11:33:52.026236Z","steps":["trace[2002279887] 'process raft request' (duration: 181.280077ms)","trace[2002279887] 'compare' (duration: 137.619917ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T11:33:52.028016Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:33:51.706702Z","time spent":"321.21943ms","remote":"127.0.0.1:52838","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-17T11:33:52.030256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.167415ms","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-10-17T11:33:52.030363Z","caller":"traceutil/trace.go:171","msg":"trace[2076173487] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25153; }","duration":"181.284348ms","start":"2026-10-17T11:33:51.849031Z","end":"2026-10-17T11:33:52.030315Z","steps":["trace[2076173487] 'agreement among raft nodes before linearized reading' (duration: 178.812329ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:33:52.430939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.143472ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-17T11:33:52.431234Z","caller":"traceutil/trace.go:171","msg":"trace[1655474791] transaction","detail":"{read_only:false; response_revision:25154; number_of_response:1; }","duration":"394.085257ms","start":"2026-10-17T11:33:52.037127Z","end":"2026-10-17T11:33:52.431212Z","steps":["trace[1655474791] 'process raft request' (duration: 239.581897ms)","trace[1655474791] 'compare' (duration: 153.762932ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T11:33:52.431302Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:33:52.037088Z","time spent":"394.179908ms","remote":"127.0.0.1:52838","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T11:33:52.443901Z","caller":"traceutil/trace.go:171","msg":"trace[637326623] transaction","detail":"{read_only:false; response_revision:25155; number_of_response:1; }","duration":"390.802558ms","start":"2026-10-17T11:33:52.053058Z","end":"2026-10-17T11:33:52.443861Z","steps":["trace[637326623] 'process raft request' (duration: 390.526051ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:33:52.444081Z","caller":"traceutil/trace.go:171","msg":"trace[1154616514] linearizableReadLoop","detail":"{readStateIndex:25980; appliedIndex:25977; }","duration":"369.353678ms","start":"2026-10-17T11:33:52.074665Z","end":"2026-10-17T11:33:52.444019Z","steps":["trace[1154616514] 'read index received' (duration: 201.94874ms)","trace[1154616514] 'applied index is now lower than readState.Index' (duration: 167.401758ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T11:33:52.444133Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:33:52.053038Z","time spent":"390.959732ms","remote":"127.0.0.1:52838","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":497,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T11:33:52.444088Z","caller":"traceutil/trace.go:171","msg":"trace[1751811905] transaction","detail":"{read_only:false; response_revision:25156; number_of_response:1; }","duration":"388.702268ms","start":"2026-10-17T11:33:52.055354Z","end":"2026-10-17T11:33:52.444056Z","steps":["trace[1751811905] 'process raft request' (duration: 388.40088ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:33:52.444261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.578873ms","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-10-17T11:33:52.444311Z","caller":"traceutil/trace.go:171","msg":"trace[413905717] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25156; }","duration":"369.672424ms","start":"2026-10-17T11:33:52.074627Z","end":"2026-10-17T11:33:52.4443Z","steps":["trace[413905717] 'agreement among raft nodes before linearized reading' (duration: 369.521331ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:33:52.444343Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:33:52.074614Z","time spent":"369.721266ms","remote":"127.0.0.1:52838","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-10-17T11:33:52.444337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"361.780537ms","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-10-17T11:33:52.444395Z","caller":"traceutil/trace.go:171","msg":"trace[1221915304] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:25156; }","duration":"361.867408ms","start":"2026-10-17T11:33:52.082511Z","end":"2026-10-17T11:33:52.444379Z","steps":["trace[1221915304] 'agreement among raft nodes before linearized reading' (duration: 361.758606ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:33:52.444401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.011855ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/\" range_end:\"/registry/cert-manager.io/certificates0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"warn","ts":"2026-10-17T11:33:52.444437Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:33:52.082502Z","time spent":"361.92508ms","remote":"127.0.0.1:52242","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":30,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "} {"level":"info","ts":"2026-10-17T11:33:52.444461Z","caller":"traceutil/trace.go:171","msg":"trace[621491672] range","detail":"{range_begin:/registry/cert-manager.io/certificates/; range_end:/registry/cert-manager.io/certificates0; response_count:0; response_revision:25156; }","duration":"347.071247ms","start":"2026-10-17T11:33:52.09737Z","end":"2026-10-17T11:33:52.444441Z","steps":["trace[621491672] 'agreement among raft nodes before linearized reading' (duration: 346.939934ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:33:52.444487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.860781ms","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-10-17T11:33:52.444517Z","caller":"traceutil/trace.go:171","msg":"trace[1150324292] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:25156; }","duration":"359.902832ms","start":"2026-10-17T11:33:52.084602Z","end":"2026-10-17T11:33:52.444505Z","steps":["trace[1150324292] 'agreement among raft nodes before linearized reading' (duration: 359.828661ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:33:52.444518Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:33:52.09734Z","time spent":"347.164388ms","remote":"127.0.0.1:47398","response type":"/etcdserverpb.KV/Range","request count":0,"request size":84,"response count":36,"response size":30,"request content":"key:\"/registry/cert-manager.io/certificates/\" range_end:\"/registry/cert-manager.io/certificates0\" count_only:true "} {"level":"warn","ts":"2026-10-17T11:33:52.444548Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:33:52.084594Z","time spent":"359.948583ms","remote":"127.0.0.1:52838","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":579,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"warn","ts":"2026-10-17T11:33:52.444288Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:33:52.055324Z","time spent":"388.905103ms","remote":"127.0.0.1:52838","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T11:33:52.602901Z","caller":"traceutil/trace.go:171","msg":"trace[736365036] transaction","detail":"{read_only:false; response_revision:25157; number_of_response:1; }","duration":"153.574368ms","start":"2026-10-17T11:33:52.4493Z","end":"2026-10-17T11:33:52.602875Z","steps":["trace[736365036] 'process raft request' (duration: 138.337855ms)","trace[736365036] 'compare' (duration: 14.991897ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:33:52.604448Z","caller":"traceutil/trace.go:171","msg":"trace[529957820] transaction","detail":"{read_only:false; response_revision:25158; number_of_response:1; }","duration":"154.46368ms","start":"2026-10-17T11:33:52.449955Z","end":"2026-10-17T11:33:52.604419Z","steps":["trace[529957820] 'process raft request' (duration: 154.192453ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:33:52.604515Z","caller":"traceutil/trace.go:171","msg":"trace[861693188] transaction","detail":"{read_only:false; response_revision:25159; number_of_response:1; }","duration":"119.288392ms","start":"2026-10-17T11:33:52.48519Z","end":"2026-10-17T11:33:52.604479Z","steps":["trace[861693188] 'process raft request' (duration: 119.064757ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:33:52.756789Z","caller":"traceutil/trace.go:171","msg":"trace[1238177503] transaction","detail":"{read_only:false; response_revision:25160; number_of_response:1; }","duration":"140.174818ms","start":"2026-10-17T11:33:52.616566Z","end":"2026-10-17T11:33:52.756741Z","steps":["trace[1238177503] 'process raft request' (duration: 136.603773ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:33:52.825204Z","caller":"traceutil/trace.go:171","msg":"trace[174338566] transaction","detail":"{read_only:false; response_revision:25161; number_of_response:1; }","duration":"208.496636ms","start":"2026-10-17T11:33:52.61668Z","end":"2026-10-17T11:33:52.825176Z","steps":["trace[174338566] 'process raft request' (duration: 208.312662ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:33:52.825387Z","caller":"traceutil/trace.go:171","msg":"trace[1246980382] linearizableReadLoop","detail":"{readStateIndex:25986; appliedIndex:25983; }","duration":"198.394946ms","start":"2026-10-17T11:33:52.626967Z","end":"2026-10-17T11:33:52.825362Z","steps":["trace[1246980382] 'read index received' (duration: 126.301019ms)","trace[1246980382] 'applied index is now lower than readState.Index' (duration: 72.092217ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:33:52.825398Z","caller":"traceutil/trace.go:171","msg":"trace[1090359777] transaction","detail":"{read_only:false; response_revision:25162; number_of_response:1; }","duration":"198.467127ms","start":"2026-10-17T11:33:52.626908Z","end":"2026-10-17T11:33:52.825375Z","steps":["trace[1090359777] 'process raft request' (duration: 198.224471ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:33:52.825607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.623131ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"warn","ts":"2026-10-17T11:33:52.825646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.415572ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/glance-api\" ","response":"range_response_count:1 size:11837"} {"level":"warn","ts":"2026-10-17T11:33:52.825646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.282469ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-10-17T11:33:52.825681Z","caller":"traceutil/trace.go:171","msg":"trace[1276847807] range","detail":"{range_begin:/registry/deployments/openstack/glance-api; range_end:; response_count:1; response_revision:25162; }","duration":"197.510514ms","start":"2026-10-17T11:33:52.628159Z","end":"2026-10-17T11:33:52.825669Z","steps":["trace[1276847807] 'agreement among raft nodes before linearized reading' (duration: 197.34021ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:33:52.825679Z","caller":"traceutil/trace.go:171","msg":"trace[417148360] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25162; }","duration":"198.732384ms","start":"2026-10-17T11:33:52.626929Z","end":"2026-10-17T11:33:52.825661Z","steps":["trace[417148360] 'agreement among raft nodes before linearized reading' (duration: 198.528469ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:33:52.825687Z","caller":"traceutil/trace.go:171","msg":"trace[699832186] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25162; }","duration":"197.364751ms","start":"2026-10-17T11:33:52.628312Z","end":"2026-10-17T11:33:52.825676Z","steps":["trace[699832186] 'agreement among raft nodes before linearized reading' (duration: 197.213568ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:35:15.125819Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":23036} {"level":"info","ts":"2026-10-17T11:35:15.263974Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":23036,"took":"133.92402ms","hash":1531373666,"current-db-size-bytes":57475072,"current-db-size":"58 MB","current-db-size-in-use-bytes":35143680,"current-db-size-in-use":"35 MB"} {"level":"info","ts":"2026-10-17T11:35:15.264079Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1531373666,"revision":23036,"compact-revision":20087} {"level":"info","ts":"2026-10-17T11:35:17.638582Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-00000000000068eb.wal"} {"level":"info","ts":"2026-10-17T11:40:15.13347Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":25991} {"level":"info","ts":"2026-10-17T11:40:15.29245Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":25991,"took":"154.336064ms","hash":1050318137,"current-db-size-bytes":57475072,"current-db-size":"58 MB","current-db-size-in-use-bytes":34541568,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-10-17T11:40:15.292643Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1050318137,"revision":25991,"compact-revision":23036} {"level":"info","ts":"2026-10-17T11:41:12.529094Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"383aa7db69884d67","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-17T11:41:12.538488Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003} {"level":"info","ts":"2026-10-17T11:41:12.538621Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003} {"level":"info","ts":"2026-10-17T11:45:15.140606Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":28658} {"level":"info","ts":"2026-10-17T11:45:15.290292Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":28658,"took":"145.426372ms","hash":2829835612,"current-db-size-bytes":57475072,"current-db-size":"58 MB","current-db-size-in-use-bytes":30482432,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-10-17T11:45:15.290366Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2829835612,"revision":28658,"compact-revision":25991} {"level":"info","ts":"2026-10-17T11:50:15.149162Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":30876} {"level":"info","ts":"2026-10-17T11:50:15.271672Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":30876,"took":"118.455269ms","hash":410371205,"current-db-size-bytes":57475072,"current-db-size":"58 MB","current-db-size-in-use-bytes":31358976,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-17T11:50:15.271737Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":410371205,"revision":30876,"compact-revision":28658} {"level":"info","ts":"2026-10-17T11:55:15.157771Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":33141} {"level":"info","ts":"2026-10-17T11:55:15.299993Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":33141,"took":"138.67823ms","hash":334834739,"current-db-size-bytes":57475072,"current-db-size":"58 MB","current-db-size-in-use-bytes":31469568,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-10-17T11:55:15.300061Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":334834739,"revision":33141,"compact-revision":30876} {"level":"info","ts":"2026-10-17T12:00:15.167942Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":35431} {"level":"info","ts":"2026-10-17T12:00:15.322857Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":35431,"took":"148.720559ms","hash":1799599342,"current-db-size-bytes":57475072,"current-db-size":"58 MB","current-db-size-in-use-bytes":33329152,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-10-17T12:00:15.322927Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1799599342,"revision":35431,"compact-revision":33141} {"level":"info","ts":"2026-10-17T12:02:29.459064Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"383aa7db69884d67","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-17T12:02:29.465591Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004} {"level":"info","ts":"2026-10-17T12:02:29.465696Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004} {"level":"info","ts":"2026-10-17T12:05:15.179449Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":37738} {"level":"info","ts":"2026-10-17T12:05:15.309824Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":37738,"took":"126.678385ms","hash":3713187692,"current-db-size-bytes":57475072,"current-db-size":"58 MB","current-db-size-in-use-bytes":32636928,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-10-17T12:05:15.309909Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3713187692,"revision":37738,"compact-revision":35431}