{"level":"warn","ts":"2026-04-13T17:12:06.881054Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-13T17:12:06.881202Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.147:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.147:2380","--initial-cluster=instance=https://199.19.213.147:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.147:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.147:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-04-13T17:12:06.881299Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-13T17:12:06.881315Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.147:2380"]} {"level":"info","ts":"2026-04-13T17:12:06.881341Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-13T17:12:06.881994Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.147:2379"]} {"level":"info","ts":"2026-04-13T17:12:06.882076Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.147:2380"],"listen-peer-urls":["https://199.19.213.147:2380"],"advertise-client-urls":["https://199.19.213.147:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.147:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.147:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-04-13T17:12:06.886335Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.032456ms"} {"level":"info","ts":"2026-04-13T17:12:06.895431Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"6244e483e416226f","cluster-id":"68a374eab3e2de92"} {"level":"info","ts":"2026-04-13T17:12:06.895545Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6244e483e416226f switched to configuration voters=()"} {"level":"info","ts":"2026-04-13T17:12:06.895573Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6244e483e416226f became follower at term 0"} {"level":"info","ts":"2026-04-13T17:12:06.895595Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 6244e483e416226f [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-13T17:12:06.895609Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6244e483e416226f became follower at term 1"} {"level":"info","ts":"2026-04-13T17:12:06.895668Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6244e483e416226f switched to configuration voters=(7081035769251766895)"} {"level":"warn","ts":"2026-04-13T17:12:06.909603Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-13T17:12:06.912138Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-13T17:12:06.91348Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-04-13T17:12:06.916628Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"6244e483e416226f","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-13T17:12:06.91703Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-13T17:12:06.917143Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-13T17:12:06.917165Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-13T17:12:06.91718Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"6244e483e416226f","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-13T17:12:06.918131Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6244e483e416226f switched to configuration voters=(7081035769251766895)"} {"level":"info","ts":"2026-04-13T17:12:06.918322Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"68a374eab3e2de92","local-member-id":"6244e483e416226f","added-peer-id":"6244e483e416226f","added-peer-peer-urls":["https://199.19.213.147:2380"]} {"level":"info","ts":"2026-04-13T17:12:06.922659Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-13T17:12:06.922863Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.147:2380"} {"level":"info","ts":"2026-04-13T17:12:06.922913Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.147:2380"} {"level":"info","ts":"2026-04-13T17:12:06.923252Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"6244e483e416226f","initial-advertise-peer-urls":["https://199.19.213.147:2380"],"listen-peer-urls":["https://199.19.213.147:2380"],"advertise-client-urls":["https://199.19.213.147:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.147:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-13T17:12:06.923313Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-13T17:12:07.096167Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6244e483e416226f is starting a new election at term 1"} {"level":"info","ts":"2026-04-13T17:12:07.096246Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6244e483e416226f became pre-candidate at term 1"} {"level":"info","ts":"2026-04-13T17:12:07.096274Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6244e483e416226f received MsgPreVoteResp from 6244e483e416226f at term 1"} {"level":"info","ts":"2026-04-13T17:12:07.096338Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6244e483e416226f became candidate at term 2"} {"level":"info","ts":"2026-04-13T17:12:07.09636Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6244e483e416226f received MsgVoteResp from 6244e483e416226f at term 2"} {"level":"info","ts":"2026-04-13T17:12:07.096382Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6244e483e416226f became leader at term 2"} {"level":"info","ts":"2026-04-13T17:12:07.096402Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 6244e483e416226f elected leader 6244e483e416226f at term 2"} {"level":"info","ts":"2026-04-13T17:12:07.097492Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-13T17:12:07.098526Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-13T17:12:07.098531Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"6244e483e416226f","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.147:2379]}","request-path":"/0/members/6244e483e416226f/attributes","cluster-id":"68a374eab3e2de92","publish-timeout":"7s"} {"level":"info","ts":"2026-04-13T17:12:07.09859Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-13T17:12:07.098993Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-13T17:12:07.099029Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-13T17:12:07.099446Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"68a374eab3e2de92","local-member-id":"6244e483e416226f","cluster-version":"3.5"} {"level":"info","ts":"2026-04-13T17:12:07.099664Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-13T17:12:07.099758Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-13T17:12:07.101236Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.147:2379"} {"level":"info","ts":"2026-04-13T17:12:07.102825Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-13T17:12:21.648423Z","caller":"traceutil/trace.go:171","msg":"trace[1778010756] transaction","detail":"{read_only:false; response_revision:363; number_of_response:1; }","duration":"115.664081ms","start":"2026-04-13T17:12:21.532725Z","end":"2026-04-13T17:12:21.648389Z","steps":["trace[1778010756] 'process raft request' (duration: 115.464446ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:12:45.059819Z","caller":"traceutil/trace.go:171","msg":"trace[1077889761] transaction","detail":"{read_only:false; response_revision:569; number_of_response:1; }","duration":"178.692144ms","start":"2026-04-13T17:12:44.8811Z","end":"2026-04-13T17:12:45.059792Z","steps":["trace[1077889761] 'process raft request' (duration: 177.683881ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:12:46.198808Z","caller":"traceutil/trace.go:171","msg":"trace[515716468] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"131.068786ms","start":"2026-04-13T17:12:46.067711Z","end":"2026-04-13T17:12:46.19878Z","steps":["trace[515716468] 'process raft request' (duration: 130.501403ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:12:46.676949Z","caller":"traceutil/trace.go:171","msg":"trace[1309667234] linearizableReadLoop","detail":"{readStateIndex:601; appliedIndex:600; }","duration":"305.478869ms","start":"2026-04-13T17:12:46.37144Z","end":"2026-04-13T17:12:46.676918Z","steps":["trace[1309667234] 'read index received' (duration: 295.402589ms)","trace[1309667234] 'applied index is now lower than readState.Index' (duration: 10.07505ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T17:12:46.677045Z","caller":"traceutil/trace.go:171","msg":"trace[552829462] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"417.518453ms","start":"2026-04-13T17:12:46.259487Z","end":"2026-04-13T17:12:46.677006Z","steps":["trace[552829462] 'process raft request' (duration: 407.459144ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:12:46.677258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.789006ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-l9fcn\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-04-13T17:12:46.677355Z","caller":"traceutil/trace.go:171","msg":"trace[1763831139] range","detail":"{range_begin:/registry/pods/kube-system/cilium-l9fcn; range_end:; response_count:1; response_revision:580; }","duration":"305.958421ms","start":"2026-04-13T17:12:46.371377Z","end":"2026-04-13T17:12:46.677335Z","steps":["trace[1763831139] 'agreement among raft nodes before linearized reading' (duration: 305.713835ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:12:46.677389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.431561ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-13T17:12:46.677454Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:12:46.371352Z","time spent":"306.084454ms","remote":"127.0.0.1:39680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16987,"request content":"key:\"/registry/pods/kube-system/cilium-l9fcn\" "} {"level":"info","ts":"2026-04-13T17:12:46.677521Z","caller":"traceutil/trace.go:171","msg":"trace[1837164337] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:580; }","duration":"161.638776ms","start":"2026-04-13T17:12:46.515852Z","end":"2026-04-13T17:12:46.677491Z","steps":["trace[1837164337] 'agreement among raft nodes before linearized reading' (duration: 161.39339ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:12:46.677789Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:12:46.259458Z","time spent":"417.715537ms","remote":"127.0.0.1:39848","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-13T17:13:13.004209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.059457ms","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-04-13T17:13:13.004412Z","caller":"traceutil/trace.go:171","msg":"trace[634671982] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:771; }","duration":"118.331564ms","start":"2026-04-13T17:13:12.886054Z","end":"2026-04-13T17:13:13.004386Z","steps":["trace[634671982] 'range keys from in-memory index tree' (duration: 117.75282ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:13:40.48562Z","caller":"traceutil/trace.go:171","msg":"trace[599603573] transaction","detail":"{read_only:false; response_revision:1166; number_of_response:1; }","duration":"116.706996ms","start":"2026-04-13T17:13:40.36889Z","end":"2026-04-13T17:13:40.485597Z","steps":["trace[599603573] 'process raft request' (duration: 116.566023ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:14:26.070335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.863849ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-13T17:14:26.070712Z","caller":"traceutil/trace.go:171","msg":"trace[349271044] transaction","detail":"{read_only:false; response_revision:1818; number_of_response:1; }","duration":"216.57165ms","start":"2026-04-13T17:14:25.854082Z","end":"2026-04-13T17:14:26.070653Z","steps":["trace[349271044] 'process raft request' (duration: 80.84978ms)","trace[349271044] 'compare' (duration: 134.630794ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T17:14:26.070842Z","caller":"traceutil/trace.go:171","msg":"trace[324279492] linearizableReadLoop","detail":"{readStateIndex:1891; appliedIndex:1889; }","duration":"134.982184ms","start":"2026-04-13T17:14:25.935835Z","end":"2026-04-13T17:14:26.070817Z","steps":["trace[324279492] 'read index received' (duration: 110.818196ms)","trace[324279492] 'applied index is now lower than readState.Index' (duration: 24.161948ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T17:14:26.070959Z","caller":"traceutil/trace.go:171","msg":"trace[1967837711] transaction","detail":"{read_only:false; response_revision:1819; number_of_response:1; }","duration":"192.458685ms","start":"2026-04-13T17:14:25.878453Z","end":"2026-04-13T17:14:26.070911Z","steps":["trace[1967837711] 'process raft request' (duration: 192.116246ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:14:26.071211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.363762ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-10f3afc5-216c-42b9-8074-c5802985a81e\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-04-13T17:14:26.071264Z","caller":"traceutil/trace.go:171","msg":"trace[1863342901] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-10f3afc5-216c-42b9-8074-c5802985a81e; range_end:; response_count:1; response_revision:1819; }","duration":"135.449984ms","start":"2026-04-13T17:14:25.9358Z","end":"2026-04-13T17:14:26.071249Z","steps":["trace[1863342901] 'agreement among raft nodes before linearized reading' (duration: 135.164967ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:14:26.329172Z","caller":"traceutil/trace.go:171","msg":"trace[1717938510] transaction","detail":"{read_only:false; response_revision:1820; number_of_response:1; }","duration":"250.015409ms","start":"2026-04-13T17:14:26.07913Z","end":"2026-04-13T17:14:26.329146Z","steps":["trace[1717938510] 'process raft request' (duration: 249.850445ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:14:26.634672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.266705ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-13T17:14:26.634866Z","caller":"traceutil/trace.go:171","msg":"trace[1274040209] linearizableReadLoop","detail":"{readStateIndex:1893; appliedIndex:1891; }","duration":"395.331477ms","start":"2026-04-13T17:14:26.239503Z","end":"2026-04-13T17:14:26.634835Z","steps":["trace[1274040209] 'read index received' (duration: 89.491156ms)","trace[1274040209] 'applied index is now lower than readState.Index' (duration: 305.837481ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T17:14:26.635258Z","caller":"traceutil/trace.go:171","msg":"trace[1470049155] transaction","detail":"{read_only:false; response_revision:1821; number_of_response:1; }","duration":"395.958022ms","start":"2026-04-13T17:14:26.239258Z","end":"2026-04-13T17:14:26.635216Z","steps":["trace[1470049155] 'process raft request' (duration: 118.97117ms)","trace[1470049155] 'compare' (duration: 275.887766ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T17:14:26.635319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"395.782977ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-10f3afc5-216c-42b9-8074-c5802985a81e\" ","response":"range_response_count:1 size:3744"} {"level":"info","ts":"2026-04-13T17:14:26.635368Z","caller":"traceutil/trace.go:171","msg":"trace[1079466059] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-10f3afc5-216c-42b9-8074-c5802985a81e; range_end:; response_count:1; response_revision:1821; }","duration":"395.858369ms","start":"2026-04-13T17:14:26.239493Z","end":"2026-04-13T17:14:26.635352Z","steps":["trace[1079466059] 'agreement among raft nodes before linearized reading' (duration: 395.420318ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:14:26.635397Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:14:26.239398Z","time spent":"395.991063ms","remote":"127.0.0.1:39680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3766,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-10f3afc5-216c-42b9-8074-c5802985a81e\" "} {"level":"warn","ts":"2026-04-13T17:14:26.635372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.751884ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"warn","ts":"2026-04-13T17:14:26.635455Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:14:26.239233Z","time spent":"396.126416ms","remote":"127.0.0.1:39772","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":554,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T17:14:26.635471Z","caller":"traceutil/trace.go:171","msg":"trace[1864719997] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1821; }","duration":"273.923749ms","start":"2026-04-13T17:14:26.361525Z","end":"2026-04-13T17:14:26.635449Z","steps":["trace[1864719997] 'agreement among raft nodes before linearized reading' (duration: 273.685663ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:14:26.635528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.002434ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-13T17:14:26.635591Z","caller":"traceutil/trace.go:171","msg":"trace[780959701] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1821; }","duration":"280.119067ms","start":"2026-04-13T17:14:26.355454Z","end":"2026-04-13T17:14:26.635573Z","steps":["trace[780959701] 'agreement among raft nodes before linearized reading' (duration: 279.752568ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:14:40.659838Z","caller":"traceutil/trace.go:171","msg":"trace[754861050] linearizableReadLoop","detail":"{readStateIndex:2012; appliedIndex:2011; }","duration":"159.06255ms","start":"2026-04-13T17:14:40.500745Z","end":"2026-04-13T17:14:40.659807Z","steps":["trace[754861050] 'read index received' (duration: 158.788483ms)","trace[754861050] 'applied index is now lower than readState.Index' (duration: 272.617µs)"],"step_count":2} {"level":"warn","ts":"2026-04-13T17:14:40.66099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.215628ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/challenges/\" range_end:\"/registry/acme.cert-manager.io/challenges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T17:14:40.661067Z","caller":"traceutil/trace.go:171","msg":"trace[1974621013] range","detail":"{range_begin:/registry/acme.cert-manager.io/challenges/; range_end:/registry/acme.cert-manager.io/challenges0; response_count:0; response_revision:1936; }","duration":"160.30256ms","start":"2026-04-13T17:14:40.500735Z","end":"2026-04-13T17:14:40.661037Z","steps":["trace[1974621013] 'agreement among raft nodes before linearized reading' (duration: 160.163806ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:14:40.661306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.02871ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T17:14:40.661341Z","caller":"traceutil/trace.go:171","msg":"trace[64109186] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1936; }","duration":"148.115241ms","start":"2026-04-13T17:14:40.513217Z","end":"2026-04-13T17:14:40.661332Z","steps":["trace[64109186] 'agreement among raft nodes before linearized reading' (duration: 148.05589ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:15:10.95058Z","caller":"traceutil/trace.go:171","msg":"trace[1206994262] transaction","detail":"{read_only:false; response_revision:2116; number_of_response:1; }","duration":"116.750758ms","start":"2026-04-13T17:15:10.833797Z","end":"2026-04-13T17:15:10.950548Z","steps":["trace[1206994262] 'process raft request' (duration: 116.464031ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:15:17.460348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.385511ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-13T17:15:17.460581Z","caller":"traceutil/trace.go:171","msg":"trace[574478105] linearizableReadLoop","detail":"{readStateIndex:2231; appliedIndex:2230; }","duration":"433.176378ms","start":"2026-04-13T17:15:17.027293Z","end":"2026-04-13T17:15:17.460469Z","steps":["trace[574478105] 'read index received' (duration: 132.47227ms)","trace[574478105] 'applied index is now lower than readState.Index' (duration: 300.702668ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T17:15:17.460762Z","caller":"traceutil/trace.go:171","msg":"trace[365110053] transaction","detail":"{read_only:false; response_revision:2148; number_of_response:1; }","duration":"461.425059ms","start":"2026-04-13T17:15:16.999321Z","end":"2026-04-13T17:15:17.460746Z","steps":["trace[365110053] 'process raft request' (duration: 160.521496ms)","trace[365110053] 'compare' (duration: 300.200136ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T17:15:17.460894Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:15:16.999272Z","time spent":"461.554702ms","remote":"127.0.0.1:39674","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8542,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T17:15:17.461249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"433.919817ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-04-13T17:15:17.461272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"409.160319ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:554"} {"level":"info","ts":"2026-04-13T17:15:17.461354Z","caller":"traceutil/trace.go:171","msg":"trace[1869472234] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2148; }","duration":"434.097361ms","start":"2026-04-13T17:15:17.027233Z","end":"2026-04-13T17:15:17.46133Z","steps":["trace[1869472234] 'agreement among raft nodes before linearized reading' (duration: 433.686621ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:15:17.461381Z","caller":"traceutil/trace.go:171","msg":"trace[1302646134] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2148; }","duration":"409.302523ms","start":"2026-04-13T17:15:17.052048Z","end":"2026-04-13T17:15:17.461351Z","steps":["trace[1302646134] 'agreement among raft nodes before linearized reading' (duration: 408.933334ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:15:17.46141Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:15:17.027211Z","time spent":"434.185802ms","remote":"127.0.0.1:39772","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-13T17:15:17.461504Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:15:17.052036Z","time spent":"409.396135ms","remote":"127.0.0.1:39772","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":576,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"warn","ts":"2026-04-13T17:15:17.461593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.335625ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T17:15:17.461647Z","caller":"traceutil/trace.go:171","msg":"trace[1055423452] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:2148; }","duration":"307.431388ms","start":"2026-04-13T17:15:17.154203Z","end":"2026-04-13T17:15:17.461634Z","steps":["trace[1055423452] 'agreement among raft nodes before linearized reading' (duration: 307.315105ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:15:17.461701Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:15:17.154153Z","time spent":"307.54058ms","remote":"127.0.0.1:39898","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":0,"response size":27,"request content":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true "} {"level":"warn","ts":"2026-04-13T17:15:17.461826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.524322ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"warn","ts":"2026-04-13T17:15:17.461848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"397.758779ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-04-13T17:15:17.461894Z","caller":"traceutil/trace.go:171","msg":"trace[92123330] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2148; }","duration":"332.645104ms","start":"2026-04-13T17:15:17.129235Z","end":"2026-04-13T17:15:17.46188Z","steps":["trace[92123330] 'agreement among raft nodes before linearized reading' (duration: 332.254245ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:15:17.461915Z","caller":"traceutil/trace.go:171","msg":"trace[1254933030] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2148; }","duration":"397.842892ms","start":"2026-04-13T17:15:17.064048Z","end":"2026-04-13T17:15:17.461891Z","steps":["trace[1254933030] 'agreement among raft nodes before linearized reading' (duration: 397.686508ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:15:17.461929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.845952ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"warn","ts":"2026-04-13T17:15:17.461969Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:15:17.129211Z","time spent":"332.745577ms","remote":"127.0.0.1:39772","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":512,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-04-13T17:15:17.462054Z","caller":"traceutil/trace.go:171","msg":"trace[1705701676] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:2148; }","duration":"339.035449ms","start":"2026-04-13T17:15:17.122981Z","end":"2026-04-13T17:15:17.462017Z","steps":["trace[1705701676] 'agreement among raft nodes before linearized reading' (duration: 338.670289ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:15:17.462117Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:15:17.122973Z","time spent":"339.131131ms","remote":"127.0.0.1:39772","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":578,"request content":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" "} {"level":"warn","ts":"2026-04-13T17:15:17.461971Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:15:17.064038Z","time spent":"397.924523ms","remote":"127.0.0.1:40980","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5434,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-04-13T17:16:43.626318Z","caller":"traceutil/trace.go:171","msg":"trace[299510449] linearizableReadLoop","detail":"{readStateIndex:2920; appliedIndex:2919; }","duration":"112.96535ms","start":"2026-04-13T17:16:43.513332Z","end":"2026-04-13T17:16:43.626298Z","steps":["trace[299510449] 'read index received' (duration: 112.765315ms)","trace[299510449] 'applied index is now lower than readState.Index' (duration: 199.164µs)"],"step_count":2} {"level":"warn","ts":"2026-04-13T17:16:43.626425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.073222ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T17:16:43.626469Z","caller":"traceutil/trace.go:171","msg":"trace[1232910452] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2810; }","duration":"113.170824ms","start":"2026-04-13T17:16:43.513287Z","end":"2026-04-13T17:16:43.626458Z","steps":["trace[1232910452] 'agreement among raft nodes before linearized reading' (duration: 113.095332ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:16:43.62644Z","caller":"traceutil/trace.go:171","msg":"trace[54323879] transaction","detail":"{read_only:false; response_revision:2810; number_of_response:1; }","duration":"120.13031ms","start":"2026-04-13T17:16:43.506268Z","end":"2026-04-13T17:16:43.626398Z","steps":["trace[54323879] 'process raft request' (duration: 119.894744ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:19:19.411056Z","caller":"traceutil/trace.go:171","msg":"trace[718987764] transaction","detail":"{read_only:false; response_revision:3834; number_of_response:1; }","duration":"122.997782ms","start":"2026-04-13T17:19:19.288034Z","end":"2026-04-13T17:19:19.411032Z","steps":["trace[718987764] 'process raft request' (duration: 122.826738ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:19:19.517312Z","caller":"traceutil/trace.go:171","msg":"trace[297456541] linearizableReadLoop","detail":"{readStateIndex:3982; appliedIndex:3980; }","duration":"166.240124ms","start":"2026-04-13T17:19:19.351047Z","end":"2026-04-13T17:19:19.517287Z","steps":["trace[297456541] 'read index received' (duration: 59.925469ms)","trace[297456541] 'applied index is now lower than readState.Index' (duration: 106.313205ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T17:19:19.517384Z","caller":"traceutil/trace.go:171","msg":"trace[527316630] transaction","detail":"{read_only:false; response_revision:3835; number_of_response:1; }","duration":"223.494998ms","start":"2026-04-13T17:19:19.293847Z","end":"2026-04-13T17:19:19.517342Z","steps":["trace[527316630] 'process raft request' (duration: 222.510115ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:19:19.517583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.52658ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"} {"level":"info","ts":"2026-04-13T17:19:19.517648Z","caller":"traceutil/trace.go:171","msg":"trace[126976903] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:3835; }","duration":"166.679684ms","start":"2026-04-13T17:19:19.350955Z","end":"2026-04-13T17:19:19.517635Z","steps":["trace[126976903] 'agreement among raft nodes before linearized reading' (duration: 166.448589ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:20:53.998268Z","caller":"traceutil/trace.go:171","msg":"trace[201096666] transaction","detail":"{read_only:false; response_revision:5058; number_of_response:1; }","duration":"121.22656ms","start":"2026-04-13T17:20:53.876995Z","end":"2026-04-13T17:20:53.998221Z","steps":["trace[201096666] 'process raft request' (duration: 120.895523ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:21:06.510083Z","caller":"traceutil/trace.go:171","msg":"trace[1126863103] transaction","detail":"{read_only:false; response_revision:5303; number_of_response:1; }","duration":"121.19685ms","start":"2026-04-13T17:21:06.388848Z","end":"2026-04-13T17:21:06.510045Z","steps":["trace[1126863103] 'process raft request' (duration: 73.603275ms)","trace[1126863103] 'compare' (duration: 47.373259ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T17:21:06.510397Z","caller":"traceutil/trace.go:171","msg":"trace[153706665] transaction","detail":"{read_only:false; response_revision:5304; number_of_response:1; }","duration":"121.499067ms","start":"2026-04-13T17:21:06.388849Z","end":"2026-04-13T17:21:06.510348Z","steps":["trace[153706665] 'process raft request' (duration: 121.137768ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:21:06.510719Z","caller":"traceutil/trace.go:171","msg":"trace[1125282588] transaction","detail":"{read_only:false; response_revision:5305; number_of_response:1; }","duration":"121.767344ms","start":"2026-04-13T17:21:06.388917Z","end":"2026-04-13T17:21:06.510684Z","steps":["trace[1125282588] 'process raft request' (duration: 121.337502ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:21:06.511039Z","caller":"traceutil/trace.go:171","msg":"trace[178921880] transaction","detail":"{read_only:false; response_revision:5306; number_of_response:1; }","duration":"117.339598ms","start":"2026-04-13T17:21:06.393686Z","end":"2026-04-13T17:21:06.511026Z","steps":["trace[178921880] 'process raft request' (duration: 116.719872ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:21:15.313677Z","caller":"traceutil/trace.go:171","msg":"trace[531048100] transaction","detail":"{read_only:false; response_revision:5466; number_of_response:1; }","duration":"107.41865ms","start":"2026-04-13T17:21:15.206221Z","end":"2026-04-13T17:21:15.31364Z","steps":["trace[531048100] 'process raft request' (duration: 107.207425ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:22:07.320342Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2944} {"level":"info","ts":"2026-04-13T17:22:07.39536Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2944,"took":"73.161634ms","hash":2099798708,"current-db-size-bytes":57982976,"current-db-size":"58 MB","current-db-size-in-use-bytes":33292288,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-04-13T17:22:07.395456Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2099798708,"revision":2944,"compact-revision":-1} {"level":"info","ts":"2026-04-13T17:27:07.327772Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5972} {"level":"info","ts":"2026-04-13T17:27:07.415815Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5972,"took":"86.152772ms","hash":2904567812,"current-db-size-bytes":57982976,"current-db-size":"58 MB","current-db-size-in-use-bytes":25329664,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-04-13T17:27:07.415892Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2904567812,"revision":5972,"compact-revision":2944} {"level":"info","ts":"2026-04-13T17:27:29.680455Z","caller":"traceutil/trace.go:171","msg":"trace[706401299] linearizableReadLoop","detail":"{readStateIndex:8645; appliedIndex:8644; }","duration":"108.963808ms","start":"2026-04-13T17:27:29.571451Z","end":"2026-04-13T17:27:29.680415Z","steps":["trace[706401299] 'read index received' (duration: 108.733983ms)","trace[706401299] 'applied index is now lower than readState.Index' (duration: 228.095µs)"],"step_count":2} {"level":"warn","ts":"2026-04-13T17:27:29.680671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.182174ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/challenges/\" range_end:\"/registry/acme.cert-manager.io/challenges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T17:27:29.680736Z","caller":"traceutil/trace.go:171","msg":"trace[1750460357] range","detail":"{range_begin:/registry/acme.cert-manager.io/challenges/; range_end:/registry/acme.cert-manager.io/challenges0; response_count:0; response_revision:8344; }","duration":"109.286646ms","start":"2026-04-13T17:27:29.571428Z","end":"2026-04-13T17:27:29.680715Z","steps":["trace[1750460357] 'agreement among raft nodes before linearized reading' (duration: 109.146403ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:27:29.680747Z","caller":"traceutil/trace.go:171","msg":"trace[1866825749] transaction","detail":"{read_only:false; response_revision:8344; number_of_response:1; }","duration":"161.010574ms","start":"2026-04-13T17:27:29.519493Z","end":"2026-04-13T17:27:29.680503Z","steps":["trace[1866825749] 'process raft request' (duration: 160.663716ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:27:29.844711Z","caller":"traceutil/trace.go:171","msg":"trace[1116379329] transaction","detail":"{read_only:false; response_revision:8345; number_of_response:1; }","duration":"151.821054ms","start":"2026-04-13T17:27:29.692846Z","end":"2026-04-13T17:27:29.844667Z","steps":["trace[1116379329] 'process raft request' (duration: 125.909834ms)","trace[1116379329] 'compare' (duration: 25.602663ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T17:27:29.857157Z","caller":"traceutil/trace.go:171","msg":"trace[517827387] transaction","detail":"{read_only:false; response_revision:8346; number_of_response:1; }","duration":"163.963615ms","start":"2026-04-13T17:27:29.693166Z","end":"2026-04-13T17:27:29.857129Z","steps":["trace[517827387] 'process raft request' (duration: 163.73614ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:27:29.857487Z","caller":"traceutil/trace.go:171","msg":"trace[370836301] linearizableReadLoop","detail":"{readStateIndex:8648; appliedIndex:8645; }","duration":"106.886638ms","start":"2026-04-13T17:27:29.75058Z","end":"2026-04-13T17:27:29.857466Z","steps":["trace[370836301] 'read index received' (duration: 68.199782ms)","trace[370836301] 'applied index is now lower than readState.Index' (duration: 38.684466ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T17:27:29.857585Z","caller":"traceutil/trace.go:171","msg":"trace[149167864] transaction","detail":"{read_only:false; response_revision:8347; number_of_response:1; }","duration":"162.895239ms","start":"2026-04-13T17:27:29.694651Z","end":"2026-04-13T17:27:29.857546Z","steps":["trace[149167864] 'process raft request' (duration: 162.422478ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:27:29.857678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.69178ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T17:27:29.857726Z","caller":"traceutil/trace.go:171","msg":"trace[1863739623] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:8347; }","duration":"105.767532ms","start":"2026-04-13T17:27:29.751945Z","end":"2026-04-13T17:27:29.857712Z","steps":["trace[1863739623] 'agreement among raft nodes before linearized reading' (duration: 105.67566ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:27:29.857729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.150535ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-13T17:27:29.857773Z","caller":"traceutil/trace.go:171","msg":"trace[222382459] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8347; }","duration":"107.235656ms","start":"2026-04-13T17:27:29.750523Z","end":"2026-04-13T17:27:29.857759Z","steps":["trace[222382459] 'agreement among raft nodes before linearized reading' (duration: 107.058702ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:27:43.453217Z","caller":"traceutil/trace.go:171","msg":"trace[1066592993] transaction","detail":"{read_only:false; response_revision:8416; number_of_response:1; }","duration":"118.648189ms","start":"2026-04-13T17:27:43.334528Z","end":"2026-04-13T17:27:43.453176Z","steps":["trace[1066592993] 'process raft request' (duration: 118.355892ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:28:13.188699Z","caller":"traceutil/trace.go:171","msg":"trace[692500063] transaction","detail":"{read_only:false; response_revision:8634; number_of_response:1; }","duration":"110.042165ms","start":"2026-04-13T17:28:13.078626Z","end":"2026-04-13T17:28:13.188668Z","steps":["trace[692500063] 'process raft request' (duration: 109.886571ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:28:13.373416Z","caller":"traceutil/trace.go:171","msg":"trace[1113294643] linearizableReadLoop","detail":"{readStateIndex:8948; appliedIndex:8946; }","duration":"283.124615ms","start":"2026-04-13T17:28:13.090261Z","end":"2026-04-13T17:28:13.373386Z","steps":["trace[1113294643] 'read index received' (duration: 98.344383ms)","trace[1113294643] 'applied index is now lower than readState.Index' (duration: 184.778962ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T17:28:13.37359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.30677ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-13T17:28:13.373621Z","caller":"traceutil/trace.go:171","msg":"trace[1096375024] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:8635; }","duration":"283.399013ms","start":"2026-04-13T17:28:13.090212Z","end":"2026-04-13T17:28:13.373611Z","steps":["trace[1096375024] 'agreement among raft nodes before linearized reading' (duration: 283.27745ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:28:13.373876Z","caller":"traceutil/trace.go:171","msg":"trace[1610917684] transaction","detail":"{read_only:false; response_revision:8635; number_of_response:1; }","duration":"294.400036ms","start":"2026-04-13T17:28:13.079433Z","end":"2026-04-13T17:28:13.373833Z","steps":["trace[1610917684] 'process raft request' (duration: 278.021204ms)","trace[1610917684] 'compare' (duration: 15.786138ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T17:28:26.778964Z","caller":"traceutil/trace.go:171","msg":"trace[677258084] transaction","detail":"{read_only:false; response_revision:8745; number_of_response:1; }","duration":"135.014331ms","start":"2026-04-13T17:28:26.643932Z","end":"2026-04-13T17:28:26.778946Z","steps":["trace[677258084] 'process raft request' (duration: 134.892378ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:28:27.505037Z","caller":"traceutil/trace.go:171","msg":"trace[1638986938] transaction","detail":"{read_only:false; response_revision:8750; number_of_response:1; }","duration":"152.366646ms","start":"2026-04-13T17:28:27.352636Z","end":"2026-04-13T17:28:27.505003Z","steps":["trace[1638986938] 'process raft request' (duration: 152.1153ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:28:27.529683Z","caller":"traceutil/trace.go:171","msg":"trace[1019894747] transaction","detail":"{read_only:false; response_revision:8751; number_of_response:1; }","duration":"103.498877ms","start":"2026-04-13T17:28:27.426163Z","end":"2026-04-13T17:28:27.529662Z","steps":["trace[1019894747] 'process raft request' (duration: 103.041247ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:28:28.40037Z","caller":"traceutil/trace.go:171","msg":"trace[1609684731] transaction","detail":"{read_only:false; response_revision:8758; number_of_response:1; }","duration":"194.099886ms","start":"2026-04-13T17:28:28.206242Z","end":"2026-04-13T17:28:28.400342Z","steps":["trace[1609684731] 'process raft request' (duration: 193.913981ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:28:28.4212Z","caller":"traceutil/trace.go:171","msg":"trace[120270891] transaction","detail":"{read_only:false; response_revision:8759; number_of_response:1; }","duration":"212.23107ms","start":"2026-04-13T17:28:28.208933Z","end":"2026-04-13T17:28:28.421164Z","steps":["trace[120270891] 'process raft request' (duration: 211.913692ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:28:28.421165Z","caller":"traceutil/trace.go:171","msg":"trace[2116203347] linearizableReadLoop","detail":"{readStateIndex:9078; appliedIndex:9077; }","duration":"201.693437ms","start":"2026-04-13T17:28:28.219438Z","end":"2026-04-13T17:28:28.421131Z","steps":["trace[2116203347] 'read index received' (duration: 180.880769ms)","trace[2116203347] 'applied index is now lower than readState.Index' (duration: 20.809888ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T17:28:28.421393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.940962ms","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":"warn","ts":"2026-04-13T17:28:28.421592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.497579ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-13T17:28:28.421651Z","caller":"traceutil/trace.go:171","msg":"trace[1266679619] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8759; }","duration":"101.653393ms","start":"2026-04-13T17:28:28.319982Z","end":"2026-04-13T17:28:28.421635Z","steps":["trace[1266679619] 'agreement among raft nodes before linearized reading' (duration: 101.429697ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:28:28.421457Z","caller":"traceutil/trace.go:171","msg":"trace[2103333413] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8759; }","duration":"202.069916ms","start":"2026-04-13T17:28:28.219368Z","end":"2026-04-13T17:28:28.421438Z","steps":["trace[2103333413] 'agreement among raft nodes before linearized reading' (duration: 201.873961ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:28:28.747174Z","caller":"traceutil/trace.go:171","msg":"trace[758171643] linearizableReadLoop","detail":"{readStateIndex:9082; appliedIndex:9081; }","duration":"239.690437ms","start":"2026-04-13T17:28:28.507453Z","end":"2026-04-13T17:28:28.747143Z","steps":["trace[758171643] 'read index received' (duration: 216.930311ms)","trace[758171643] 'applied index is now lower than readState.Index' (duration: 22.758236ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T17:28:28.747847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.361202ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:26 size:228498"} {"level":"info","ts":"2026-04-13T17:28:28.747971Z","caller":"traceutil/trace.go:171","msg":"trace[1656458027] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:26; response_revision:8763; }","duration":"240.512686ms","start":"2026-04-13T17:28:28.507437Z","end":"2026-04-13T17:28:28.74795Z","steps":["trace[1656458027] 'agreement among raft nodes before linearized reading' (duration: 239.824579ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:28:28.748551Z","caller":"traceutil/trace.go:171","msg":"trace[499950929] transaction","detail":"{read_only:false; response_revision:8763; number_of_response:1; }","duration":"245.579057ms","start":"2026-04-13T17:28:28.501635Z","end":"2026-04-13T17:28:28.747214Z","steps":["trace[499950929] 'process raft request' (duration: 222.814611ms)","trace[499950929] 'compare' (duration: 22.422767ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T17:28:50.874547Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-000000000000248d.wal"} {"level":"info","ts":"2026-04-13T17:29:45.017685Z","caller":"traceutil/trace.go:171","msg":"trace[1971929182] linearizableReadLoop","detail":"{readStateIndex:9844; appliedIndex:9843; }","duration":"101.863966ms","start":"2026-04-13T17:29:44.915785Z","end":"2026-04-13T17:29:45.017649Z","steps":["trace[1971929182] 'read index received' (duration: 101.622731ms)","trace[1971929182] 'applied index is now lower than readState.Index' (duration: 239.965µs)"],"step_count":2} {"level":"info","ts":"2026-04-13T17:29:45.017778Z","caller":"traceutil/trace.go:171","msg":"trace[1856370690] transaction","detail":"{read_only:false; response_revision:9504; number_of_response:1; }","duration":"120.086591ms","start":"2026-04-13T17:29:44.897652Z","end":"2026-04-13T17:29:45.017739Z","steps":["trace[1856370690] 'process raft request' (duration: 119.787104ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:29:45.018109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.274566ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-13T17:29:45.01824Z","caller":"traceutil/trace.go:171","msg":"trace[964891791] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:9504; }","duration":"102.497781ms","start":"2026-04-13T17:29:44.915712Z","end":"2026-04-13T17:29:45.01821Z","steps":["trace[964891791] 'agreement among raft nodes before linearized reading' (duration: 102.106252ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:29:45.146605Z","caller":"traceutil/trace.go:171","msg":"trace[1459782523] transaction","detail":"{read_only:false; response_revision:9505; number_of_response:1; }","duration":"123.053222ms","start":"2026-04-13T17:29:45.023507Z","end":"2026-04-13T17:29:45.146561Z","steps":["trace[1459782523] 'process raft request' (duration: 122.772536ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:29:45.183431Z","caller":"traceutil/trace.go:171","msg":"trace[1767237871] transaction","detail":"{read_only:false; response_revision:9507; number_of_response:1; }","duration":"159.444952ms","start":"2026-04-13T17:29:45.023953Z","end":"2026-04-13T17:29:45.183398Z","steps":["trace[1767237871] 'process raft request' (duration: 159.37947ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:29:45.183471Z","caller":"traceutil/trace.go:171","msg":"trace[2086728155] transaction","detail":"{read_only:false; response_revision:9506; number_of_response:1; }","duration":"159.691728ms","start":"2026-04-13T17:29:45.023752Z","end":"2026-04-13T17:29:45.183444Z","steps":["trace[2086728155] 'process raft request' (duration: 159.34996ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:30:03.278899Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"6244e483e416226f","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-13T17:30:03.296672Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-13T17:30:03.296797Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-13T17:32:07.336218Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8049} {"level":"info","ts":"2026-04-13T17:32:07.406809Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8049,"took":"59.846861ms","hash":3086214501,"current-db-size-bytes":57982976,"current-db-size":"58 MB","current-db-size-in-use-bytes":28086272,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-04-13T17:32:07.406868Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3086214501,"revision":8049,"compact-revision":5972} {"level":"info","ts":"2026-04-13T17:37:07.344682Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10458} {"level":"info","ts":"2026-04-13T17:37:07.427297Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10458,"took":"79.285054ms","hash":891333429,"current-db-size-bytes":57982976,"current-db-size":"58 MB","current-db-size-in-use-bytes":22032384,"current-db-size-in-use":"22 MB"} {"level":"info","ts":"2026-04-13T17:37:07.427377Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":891333429,"revision":10458,"compact-revision":8049}