{"level":"warn","ts":"2026-07-21T05:24:44.290654Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-21T05:24:44.290739Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.20: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.20:2380","--initial-cluster=instance=https://199.19.213.20:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.20:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.20:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-07-21T05:24:44.290816Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-21T05:24:44.290828Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.20:2380"]} {"level":"info","ts":"2026-07-21T05:24:44.290843Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-07-21T05:24:44.29145Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.20:2379"]} {"level":"info","ts":"2026-07-21T05:24:44.291519Z","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":8,"max-cpu-available":8,"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.20:2380"],"listen-peer-urls":["https://199.19.213.20:2380"],"advertise-client-urls":["https://199.19.213.20:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.20:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.20:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-07-21T05:24:44.29485Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.151695ms"} {"level":"info","ts":"2026-07-21T05:24:44.301367Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"185293d8d40ffce0","cluster-id":"cc857afa6e1fa648"} {"level":"info","ts":"2026-07-21T05:24:44.30147Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"185293d8d40ffce0 switched to configuration voters=()"} {"level":"info","ts":"2026-07-21T05:24:44.301499Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"185293d8d40ffce0 became follower at term 0"} {"level":"info","ts":"2026-07-21T05:24:44.301517Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 185293d8d40ffce0 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-21T05:24:44.301545Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"185293d8d40ffce0 became follower at term 1"} {"level":"info","ts":"2026-07-21T05:24:44.301592Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"185293d8d40ffce0 switched to configuration voters=(1752625764480580832)"} {"level":"warn","ts":"2026-07-21T05:24:44.310167Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-21T05:24:44.31357Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-21T05:24:44.315711Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-07-21T05:24:44.32193Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"185293d8d40ffce0","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-21T05:24:44.32212Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-07-21T05:24:44.32221Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-07-21T05:24:44.322258Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-07-21T05:24:44.322344Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"185293d8d40ffce0","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-21T05:24:44.323594Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"185293d8d40ffce0 switched to configuration voters=(1752625764480580832)"} {"level":"info","ts":"2026-07-21T05:24:44.323777Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"cc857afa6e1fa648","local-member-id":"185293d8d40ffce0","added-peer-id":"185293d8d40ffce0","added-peer-peer-urls":["https://199.19.213.20:2380"]} {"level":"info","ts":"2026-07-21T05:24:44.326817Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-07-21T05:24:44.327041Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"185293d8d40ffce0","initial-advertise-peer-urls":["https://199.19.213.20:2380"],"listen-peer-urls":["https://199.19.213.20:2380"],"advertise-client-urls":["https://199.19.213.20:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.20:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-21T05:24:44.327081Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-21T05:24:44.327214Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.20:2380"} {"level":"info","ts":"2026-07-21T05:24:44.327233Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.20:2380"} {"level":"info","ts":"2026-07-21T05:24:45.002076Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"185293d8d40ffce0 is starting a new election at term 1"} {"level":"info","ts":"2026-07-21T05:24:45.002141Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"185293d8d40ffce0 became pre-candidate at term 1"} {"level":"info","ts":"2026-07-21T05:24:45.002183Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"185293d8d40ffce0 received MsgPreVoteResp from 185293d8d40ffce0 at term 1"} {"level":"info","ts":"2026-07-21T05:24:45.002211Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"185293d8d40ffce0 became candidate at term 2"} {"level":"info","ts":"2026-07-21T05:24:45.00223Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"185293d8d40ffce0 received MsgVoteResp from 185293d8d40ffce0 at term 2"} {"level":"info","ts":"2026-07-21T05:24:45.002245Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"185293d8d40ffce0 became leader at term 2"} {"level":"info","ts":"2026-07-21T05:24:45.002258Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 185293d8d40ffce0 elected leader 185293d8d40ffce0 at term 2"} {"level":"info","ts":"2026-07-21T05:24:45.003276Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-21T05:24:45.004255Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-21T05:24:45.004223Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"185293d8d40ffce0","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.20:2379]}","request-path":"/0/members/185293d8d40ffce0/attributes","cluster-id":"cc857afa6e1fa648","publish-timeout":"7s"} {"level":"info","ts":"2026-07-21T05:24:45.004587Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"cc857afa6e1fa648","local-member-id":"185293d8d40ffce0","cluster-version":"3.5"} {"level":"info","ts":"2026-07-21T05:24:45.004698Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-21T05:24:45.004662Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-21T05:24:45.004742Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-21T05:24:45.004825Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-21T05:24:45.004846Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-21T05:24:45.006119Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-21T05:24:45.007336Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.20:2379"} {"level":"info","ts":"2026-07-21T05:25:30.358502Z","caller":"traceutil/trace.go:171","msg":"trace[882246398] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"102.079841ms","start":"2026-07-21T05:25:30.25636Z","end":"2026-07-21T05:25:30.35844Z","steps":["trace[882246398] 'process raft request' (duration: 101.648304ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T05:25:30.358523Z","caller":"traceutil/trace.go:171","msg":"trace[206208988] transaction","detail":"{read_only:false; response_revision:561; number_of_response:1; }","duration":"101.287148ms","start":"2026-07-21T05:25:30.257198Z","end":"2026-07-21T05:25:30.358485Z","steps":["trace[206208988] 'process raft request' (duration: 101.009414ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T05:25:30.358601Z","caller":"traceutil/trace.go:171","msg":"trace[650215346] transaction","detail":"{read_only:false; response_revision:559; number_of_response:1; }","duration":"102.00322ms","start":"2026-07-21T05:25:30.256575Z","end":"2026-07-21T05:25:30.358578Z","steps":["trace[650215346] 'process raft request' (duration: 101.545752ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T05:25:30.358629Z","caller":"traceutil/trace.go:171","msg":"trace[1352038643] transaction","detail":"{read_only:false; response_revision:560; number_of_response:1; }","duration":"101.936849ms","start":"2026-07-21T05:25:30.256685Z","end":"2026-07-21T05:25:30.358622Z","steps":["trace[1352038643] 'process raft request' (duration: 101.475381ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T05:25:31.770081Z","caller":"traceutil/trace.go:171","msg":"trace[920088241] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"115.746438ms","start":"2026-07-21T05:25:31.654309Z","end":"2026-07-21T05:25:31.770055Z","steps":["trace[920088241] 'process raft request' (duration: 115.308141ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T05:25:36.276364Z","caller":"traceutil/trace.go:171","msg":"trace[305978765] transaction","detail":"{read_only:false; response_revision:647; number_of_response:1; }","duration":"163.803454ms","start":"2026-07-21T05:25:36.112525Z","end":"2026-07-21T05:25:36.276329Z","steps":["trace[305978765] 'process raft request' (duration: 163.295234ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T05:25:36.555107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.656991ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-21T05:25:36.555387Z","caller":"traceutil/trace.go:171","msg":"trace[682304075] transaction","detail":"{read_only:false; response_revision:649; number_of_response:1; }","duration":"218.13121ms","start":"2026-07-21T05:25:36.337235Z","end":"2026-07-21T05:25:36.555366Z","steps":["trace[682304075] 'process raft request' (duration: 32.723366ms)","trace[682304075] 'compare' (duration: 184.518259ms)"],"step_count":2} {"level":"warn","ts":"2026-07-21T05:25:37.040315Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.221125ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-21T05:25:37.040459Z","caller":"traceutil/trace.go:171","msg":"trace[1674609885] linearizableReadLoop","detail":"{readStateIndex:677; appliedIndex:676; }","duration":"282.263978ms","start":"2026-07-21T05:25:36.758147Z","end":"2026-07-21T05:25:37.040411Z","steps":["trace[1674609885] 'read index received' (duration: 137.602506ms)","trace[1674609885] 'applied index is now lower than readState.Index' (duration: 144.660402ms)"],"step_count":2} {"level":"info","ts":"2026-07-21T05:25:37.040534Z","caller":"traceutil/trace.go:171","msg":"trace[922835589] transaction","detail":"{read_only:false; response_revision:650; number_of_response:1; }","duration":"445.449172ms","start":"2026-07-21T05:25:36.595049Z","end":"2026-07-21T05:25:37.040498Z","steps":["trace[922835589] 'process raft request' (duration: 300.79891ms)","trace[922835589] 'compare' (duration: 144.108513ms)"],"step_count":2} {"level":"warn","ts":"2026-07-21T05:25:37.04061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.456551ms","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-07-21T05:25:37.040662Z","caller":"traceutil/trace.go:171","msg":"trace[1409778961] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:650; }","duration":"282.539472ms","start":"2026-07-21T05:25:36.758111Z","end":"2026-07-21T05:25:37.04065Z","steps":["trace[1409778961] 'agreement among raft nodes before linearized reading' (duration: 282.39758ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T05:25:37.040707Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T05:25:36.595031Z","time spent":"445.583174ms","remote":"127.0.0.1:59826","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-21T05:25:37.080137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.682558ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-nfbdg\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-07-21T05:25:37.080213Z","caller":"traceutil/trace.go:171","msg":"trace[768595790] range","detail":"{range_begin:/registry/pods/kube-system/cilium-nfbdg; range_end:; response_count:1; response_revision:651; }","duration":"197.83281ms","start":"2026-07-21T05:25:36.882362Z","end":"2026-07-21T05:25:37.080195Z","steps":["trace[768595790] 'agreement among raft nodes before linearized reading' (duration: 197.664127ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T05:25:37.080147Z","caller":"traceutil/trace.go:171","msg":"trace[1391142639] transaction","detail":"{read_only:false; response_revision:651; number_of_response:1; }","duration":"106.858982ms","start":"2026-07-21T05:25:36.973264Z","end":"2026-07-21T05:25:37.080123Z","steps":["trace[1391142639] 'process raft request' (duration: 106.275022ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T05:25:37.080267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.744135ms","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-07-21T05:25:37.080332Z","caller":"traceutil/trace.go:171","msg":"trace[938437173] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:651; }","duration":"120.841587ms","start":"2026-07-21T05:25:36.959475Z","end":"2026-07-21T05:25:37.080317Z","steps":["trace[938437173] 'agreement among raft nodes before linearized reading' (duration: 120.668944ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T05:25:52.220917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.891515ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-21T05:25:52.221105Z","caller":"traceutil/trace.go:171","msg":"trace[615929286] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:816; }","duration":"126.070108ms","start":"2026-07-21T05:25:52.094972Z","end":"2026-07-21T05:25:52.221042Z","steps":["trace[615929286] 'range keys from in-memory index tree' (duration: 125.871594ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T05:26:20.74652Z","caller":"traceutil/trace.go:171","msg":"trace[1948443164] transaction","detail":"{read_only:false; response_revision:1216; number_of_response:1; }","duration":"138.633066ms","start":"2026-07-21T05:26:20.607862Z","end":"2026-07-21T05:26:20.746495Z","steps":["trace[1948443164] 'process raft request' (duration: 95.145695ms)","trace[1948443164] 'compare' (duration: 43.38919ms)"],"step_count":2} {"level":"info","ts":"2026-07-21T05:26:31.470808Z","caller":"traceutil/trace.go:171","msg":"trace[1788885563] transaction","detail":"{read_only:false; response_revision:1307; number_of_response:1; }","duration":"100.724593ms","start":"2026-07-21T05:26:31.370052Z","end":"2026-07-21T05:26:31.470777Z","steps":["trace[1788885563] 'process raft request' (duration: 59.084687ms)","trace[1788885563] 'compare' (duration: 41.505424ms)"],"step_count":2} {"level":"info","ts":"2026-07-21T05:26:52.144124Z","caller":"traceutil/trace.go:171","msg":"trace[1047754084] transaction","detail":"{read_only:false; response_revision:1657; number_of_response:1; }","duration":"103.521966ms","start":"2026-07-21T05:26:52.04053Z","end":"2026-07-21T05:26:52.144052Z","steps":["trace[1047754084] 'process raft request' (duration: 52.359418ms)","trace[1047754084] 'compare' (duration: 50.987555ms)"],"step_count":2} {"level":"info","ts":"2026-07-21T05:27:07.451744Z","caller":"traceutil/trace.go:171","msg":"trace[921247207] linearizableReadLoop","detail":"{readStateIndex:1954; appliedIndex:1953; }","duration":"165.354429ms","start":"2026-07-21T05:27:07.286364Z","end":"2026-07-21T05:27:07.451719Z","steps":["trace[921247207] 'read index received' (duration: 165.188055ms)","trace[921247207] 'applied index is now lower than readState.Index' (duration: 165.214µs)"],"step_count":2} {"level":"info","ts":"2026-07-21T05:27:07.45209Z","caller":"traceutil/trace.go:171","msg":"trace[1957381917] transaction","detail":"{read_only:false; response_revision:1876; number_of_response:1; }","duration":"171.309622ms","start":"2026-07-21T05:27:07.280749Z","end":"2026-07-21T05:27:07.452059Z","steps":["trace[1957381917] 'process raft request' (duration: 170.787633ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T05:27:07.452144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.734294ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-21T05:27:07.452193Z","caller":"traceutil/trace.go:171","msg":"trace[489432480] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:1876; }","duration":"165.848197ms","start":"2026-07-21T05:27:07.286335Z","end":"2026-07-21T05:27:07.452183Z","steps":["trace[489432480] 'agreement among raft nodes before linearized reading' (duration: 165.717665ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T05:27:07.452225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.384714ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-haproxy-0\" ","response":"range_response_count:1 size:10629"} {"level":"info","ts":"2026-07-21T05:27:07.452285Z","caller":"traceutil/trace.go:171","msg":"trace[2074979949] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-haproxy-0; range_end:; response_count:1; response_revision:1876; }","duration":"104.497276ms","start":"2026-07-21T05:27:07.347775Z","end":"2026-07-21T05:27:07.452272Z","steps":["trace[2074979949] 'agreement among raft nodes before linearized reading' (duration: 104.265363ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T05:27:07.568547Z","caller":"traceutil/trace.go:171","msg":"trace[1135883183] transaction","detail":"{read_only:false; response_revision:1877; number_of_response:1; }","duration":"105.988469ms","start":"2026-07-21T05:27:07.462539Z","end":"2026-07-21T05:27:07.568528Z","steps":["trace[1135883183] 'process raft request' (duration: 105.822286ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T05:27:07.856118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.680436ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-21T05:27:07.856839Z","caller":"traceutil/trace.go:171","msg":"trace[1685592078] linearizableReadLoop","detail":"{readStateIndex:1956; appliedIndex:1955; }","duration":"285.552408ms","start":"2026-07-21T05:27:07.571269Z","end":"2026-07-21T05:27:07.856821Z","steps":["trace[1685592078] 'read index received' (duration: 22.969679ms)","trace[1685592078] 'applied index is now lower than readState.Index' (duration: 262.580639ms)"],"step_count":2} {"level":"info","ts":"2026-07-21T05:27:07.856895Z","caller":"traceutil/trace.go:171","msg":"trace[12563777] transaction","detail":"{read_only:false; response_revision:1878; number_of_response:1; }","duration":"287.614831ms","start":"2026-07-21T05:27:07.569272Z","end":"2026-07-21T05:27:07.856887Z","steps":["trace[12563777] 'process raft request' (duration: 25.051012ms)","trace[12563777] 'compare' (duration: 261.520563ms)"],"step_count":2} {"level":"warn","ts":"2026-07-21T05:27:07.857097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.822762ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-6fa9eae2-b2b3-4f0e-ada9-f1bea65e1153\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-07-21T05:27:07.857127Z","caller":"traceutil/trace.go:171","msg":"trace[445378201] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-6fa9eae2-b2b3-4f0e-ada9-f1bea65e1153; range_end:; response_count:1; response_revision:1878; }","duration":"285.875044ms","start":"2026-07-21T05:27:07.571244Z","end":"2026-07-21T05:27:07.857119Z","steps":["trace[445378201] 'agreement among raft nodes before linearized reading' (duration: 285.775322ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T05:27:07.888202Z","caller":"traceutil/trace.go:171","msg":"trace[2012537852] transaction","detail":"{read_only:false; response_revision:1879; number_of_response:1; }","duration":"314.684365ms","start":"2026-07-21T05:27:07.573484Z","end":"2026-07-21T05:27:07.888168Z","steps":["trace[2012537852] 'process raft request' (duration: 314.39551ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T05:27:07.888265Z","caller":"traceutil/trace.go:171","msg":"trace[2048998887] transaction","detail":"{read_only:false; response_revision:1880; number_of_response:1; }","duration":"313.554466ms","start":"2026-07-21T05:27:07.574673Z","end":"2026-07-21T05:27:07.888227Z","steps":["trace[2048998887] 'process raft request' (duration: 313.350953ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T05:27:07.888455Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T05:27:07.574667Z","time spent":"313.679858ms","remote":"127.0.0.1:59840","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1529,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-21T05:27:07.888537Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T05:27:07.573473Z","time spent":"314.837997ms","remote":"127.0.0.1:59732","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":977,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-21T05:27:07.888627Z","caller":"traceutil/trace.go:171","msg":"trace[1973527412] transaction","detail":"{read_only:false; response_revision:1881; number_of_response:1; }","duration":"313.090898ms","start":"2026-07-21T05:27:07.57552Z","end":"2026-07-21T05:27:07.888611Z","steps":["trace[1973527412] 'process raft request' (duration: 312.55557ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T05:27:07.888722Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T05:27:07.575513Z","time spent":"313.1626ms","remote":"127.0.0.1:59732","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":893,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-21T05:27:07.888713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.033946ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-07-21T05:27:07.888531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.932181ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/datadir-percona-xtradb-pxc-0.18c436d11c900d4c\" ","response":"range_response_count:1 size:982"} {"level":"info","ts":"2026-07-21T05:27:07.888911Z","caller":"traceutil/trace.go:171","msg":"trace[1973360447] transaction","detail":"{read_only:false; response_revision:1882; number_of_response:1; }","duration":"311.86384ms","start":"2026-07-21T05:27:07.577022Z","end":"2026-07-21T05:27:07.888886Z","steps":["trace[1973360447] 'process raft request' (duration: 311.173779ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T05:27:07.888976Z","caller":"traceutil/trace.go:171","msg":"trace[1494461921] range","detail":"{range_begin:/registry/events/openstack/datadir-percona-xtradb-pxc-0.18c436d11c900d4c; range_end:; response_count:1; response_revision:1882; }","duration":"312.42741ms","start":"2026-07-21T05:27:07.576528Z","end":"2026-07-21T05:27:07.888956Z","steps":["trace[1494461921] 'agreement among raft nodes before linearized reading' (duration: 311.723278ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T05:27:07.889031Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T05:27:07.576522Z","time spent":"312.49411ms","remote":"127.0.0.1:59640","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":1005,"request content":"key:\"/registry/events/openstack/datadir-percona-xtradb-pxc-0.18c436d11c900d4c\" "} {"level":"warn","ts":"2026-07-21T05:27:07.889059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.403543ms","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-07-21T05:27:07.888801Z","caller":"traceutil/trace.go:171","msg":"trace[1683227100] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1882; }","duration":"162.145537ms","start":"2026-07-21T05:27:07.726636Z","end":"2026-07-21T05:27:07.888781Z","steps":["trace[1683227100] 'agreement among raft nodes before linearized reading' (duration: 161.971273ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T05:27:07.889141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.699113ms","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-07-21T05:27:07.889117Z","caller":"traceutil/trace.go:171","msg":"trace[203670864] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1882; }","duration":"164.489354ms","start":"2026-07-21T05:27:07.724618Z","end":"2026-07-21T05:27:07.889107Z","steps":["trace[203670864] 'agreement among raft nodes before linearized reading' (duration: 164.356192ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T05:27:07.889195Z","caller":"traceutil/trace.go:171","msg":"trace[263720351] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1882; }","duration":"181.796295ms","start":"2026-07-21T05:27:07.707387Z","end":"2026-07-21T05:27:07.889183Z","steps":["trace[263720351] 'agreement among raft nodes before linearized reading' (duration: 181.606402ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T05:27:07.889444Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T05:27:07.577015Z","time spent":"312.351999ms","remote":"127.0.0.1:59840","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1471,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-21T05:27:07.974311Z","caller":"traceutil/trace.go:171","msg":"trace[1388629359] transaction","detail":"{read_only:false; response_revision:1883; number_of_response:1; }","duration":"108.706891ms","start":"2026-07-21T05:27:07.865578Z","end":"2026-07-21T05:27:07.974285Z","steps":["trace[1388629359] 'process raft request' (duration: 104.023888ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T05:27:08.070162Z","caller":"traceutil/trace.go:171","msg":"trace[1209061335] transaction","detail":"{read_only:false; response_revision:1884; number_of_response:1; }","duration":"176.718525ms","start":"2026-07-21T05:27:07.893406Z","end":"2026-07-21T05:27:08.070125Z","steps":["trace[1209061335] 'process raft request' (duration: 176.44081ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T05:27:08.070178Z","caller":"traceutil/trace.go:171","msg":"trace[1007714153] transaction","detail":"{read_only:false; response_revision:1885; number_of_response:1; }","duration":"173.797569ms","start":"2026-07-21T05:27:07.896356Z","end":"2026-07-21T05:27:08.070153Z","steps":["trace[1007714153] 'process raft request' (duration: 173.658937ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T05:27:08.070498Z","caller":"traceutil/trace.go:171","msg":"trace[737171457] transaction","detail":"{read_only:false; response_revision:1886; number_of_response:1; }","duration":"168.543967ms","start":"2026-07-21T05:27:07.901941Z","end":"2026-07-21T05:27:08.070485Z","steps":["trace[737171457] 'process raft request' (duration: 168.172681ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T05:27:08.070783Z","caller":"traceutil/trace.go:171","msg":"trace[1316676810] transaction","detail":"{read_only:false; response_revision:1887; number_of_response:1; }","duration":"168.7691ms","start":"2026-07-21T05:27:07.901989Z","end":"2026-07-21T05:27:08.070758Z","steps":["trace[1316676810] 'process raft request' (duration: 168.451945ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T05:27:08.317913Z","caller":"traceutil/trace.go:171","msg":"trace[705733664] linearizableReadLoop","detail":"{readStateIndex:1967; appliedIndex:1966; }","duration":"166.88646ms","start":"2026-07-21T05:27:08.151003Z","end":"2026-07-21T05:27:08.31789Z","steps":["trace[705733664] 'read index received' (duration: 75.253716ms)","trace[705733664] 'applied index is now lower than readState.Index' (duration: 91.631804ms)"],"step_count":2} {"level":"warn","ts":"2026-07-21T05:27:08.318118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.091464ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-6fa9eae2-b2b3-4f0e-ada9-f1bea65e1153\" ","response":"range_response_count:1 size:3746"} {"level":"info","ts":"2026-07-21T05:27:08.318059Z","caller":"traceutil/trace.go:171","msg":"trace[728477679] transaction","detail":"{read_only:false; response_revision:1888; number_of_response:1; }","duration":"193.261093ms","start":"2026-07-21T05:27:08.124758Z","end":"2026-07-21T05:27:08.318019Z","steps":["trace[728477679] 'process raft request' (duration: 101.553258ms)","trace[728477679] 'compare' (duration: 91.474491ms)"],"step_count":2} {"level":"info","ts":"2026-07-21T05:27:08.318156Z","caller":"traceutil/trace.go:171","msg":"trace[335170530] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-6fa9eae2-b2b3-4f0e-ada9-f1bea65e1153; range_end:; response_count:1; response_revision:1888; }","duration":"167.171305ms","start":"2026-07-21T05:27:08.150975Z","end":"2026-07-21T05:27:08.318146Z","steps":["trace[335170530] 'agreement among raft nodes before linearized reading' (duration: 167.001822ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T05:27:19.635498Z","caller":"traceutil/trace.go:171","msg":"trace[1699029261] linearizableReadLoop","detail":"{readStateIndex:2067; appliedIndex:2066; }","duration":"128.70783ms","start":"2026-07-21T05:27:19.50677Z","end":"2026-07-21T05:27:19.635477Z","steps":["trace[1699029261] 'read index received' (duration: 128.499057ms)","trace[1699029261] 'applied index is now lower than readState.Index' (duration: 207.973µs)"],"step_count":2} {"level":"warn","ts":"2026-07-21T05:27:19.635636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.862512ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-21T05:27:19.635667Z","caller":"traceutil/trace.go:171","msg":"trace[500050698] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1985; }","duration":"128.906383ms","start":"2026-07-21T05:27:19.50675Z","end":"2026-07-21T05:27:19.635656Z","steps":["trace[500050698] 'agreement among raft nodes before linearized reading' (duration: 128.839422ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T05:27:19.635651Z","caller":"traceutil/trace.go:171","msg":"trace[1001801798] transaction","detail":"{read_only:false; response_revision:1985; number_of_response:1; }","duration":"129.391601ms","start":"2026-07-21T05:27:19.506204Z","end":"2026-07-21T05:27:19.635596Z","steps":["trace[1001801798] 'process raft request' (duration: 129.118277ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T05:27:19.635875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.598916ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:11981"} {"level":"info","ts":"2026-07-21T05:27:19.635943Z","caller":"traceutil/trace.go:171","msg":"trace[93656270] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:1985; }","duration":"115.697888ms","start":"2026-07-21T05:27:19.520227Z","end":"2026-07-21T05:27:19.635925Z","steps":["trace[93656270] 'agreement among raft nodes before linearized reading' (duration: 115.512195ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T05:27:19.636039Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.097592ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-07-21T05:27:19.636076Z","caller":"traceutil/trace.go:171","msg":"trace[272355275] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1985; }","duration":"103.142983ms","start":"2026-07-21T05:27:19.53292Z","end":"2026-07-21T05:27:19.636063Z","steps":["trace[272355275] 'agreement among raft nodes before linearized reading' (duration: 103.025911ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T05:27:55.902637Z","caller":"traceutil/trace.go:171","msg":"trace[1256218532] transaction","detail":"{read_only:false; response_revision:2194; number_of_response:1; }","duration":"104.243258ms","start":"2026-07-21T05:27:55.798359Z","end":"2026-07-21T05:27:55.902602Z","steps":["trace[1256218532] 'process raft request' (duration: 103.854732ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T05:27:56.200259Z","caller":"traceutil/trace.go:171","msg":"trace[267437928] transaction","detail":"{read_only:false; response_revision:2195; number_of_response:1; }","duration":"179.179168ms","start":"2026-07-21T05:27:56.021059Z","end":"2026-07-21T05:27:56.200238Z","steps":["trace[267437928] 'process raft request' (duration: 160.034826ms)","trace[267437928] 'compare' (duration: 18.919799ms)"],"step_count":2} {"level":"info","ts":"2026-07-21T05:27:56.492184Z","caller":"traceutil/trace.go:171","msg":"trace[841979226] linearizableReadLoop","detail":"{readStateIndex:2286; appliedIndex:2285; }","duration":"199.912264ms","start":"2026-07-21T05:27:56.292236Z","end":"2026-07-21T05:27:56.492149Z","steps":["trace[841979226] 'read index received' (duration: 104.465281ms)","trace[841979226] 'applied index is now lower than readState.Index' (duration: 95.445623ms)"],"step_count":2} {"level":"info","ts":"2026-07-21T05:27:56.492382Z","caller":"traceutil/trace.go:171","msg":"trace[2079587688] transaction","detail":"{read_only:false; response_revision:2196; number_of_response:1; }","duration":"206.17887ms","start":"2026-07-21T05:27:56.286098Z","end":"2026-07-21T05:27:56.492276Z","steps":["trace[2079587688] 'process raft request' (duration: 110.587373ms)","trace[2079587688] 'compare' (duration: 95.261791ms)"],"step_count":2} {"level":"warn","ts":"2026-07-21T05:27:56.492628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.077025ms","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-07-21T05:27:56.492799Z","caller":"traceutil/trace.go:171","msg":"trace[1041567610] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2196; }","duration":"173.313779ms","start":"2026-07-21T05:27:56.319458Z","end":"2026-07-21T05:27:56.492772Z","steps":["trace[1041567610] 'agreement among raft nodes before linearized reading' (duration: 172.940274ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T05:27:56.492668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.409652ms","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-07-21T05:27:56.492946Z","caller":"traceutil/trace.go:171","msg":"trace[997283331] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2196; }","duration":"200.719136ms","start":"2026-07-21T05:27:56.292214Z","end":"2026-07-21T05:27:56.492933Z","steps":["trace[997283331] 'agreement among raft nodes before linearized reading' (duration: 200.081527ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T05:28:36.797648Z","caller":"traceutil/trace.go:171","msg":"trace[1248182631] transaction","detail":"{read_only:false; response_revision:2521; number_of_response:1; }","duration":"111.18629ms","start":"2026-07-21T05:28:36.686431Z","end":"2026-07-21T05:28:36.797617Z","steps":["trace[1248182631] 'process raft request' (duration: 108.605451ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T05:29:14.48352Z","caller":"traceutil/trace.go:171","msg":"trace[1773051128] linearizableReadLoop","detail":"{readStateIndex:2834; appliedIndex:2833; }","duration":"162.615382ms","start":"2026-07-21T05:29:14.320876Z","end":"2026-07-21T05:29:14.483491Z","steps":["trace[1773051128] 'read index received' (duration: 162.558851ms)","trace[1773051128] 'applied index is now lower than readState.Index' (duration: 54.941µs)"],"step_count":2} {"level":"info","ts":"2026-07-21T05:29:14.483635Z","caller":"traceutil/trace.go:171","msg":"trace[1876909135] transaction","detail":"{read_only:false; response_revision:2726; number_of_response:1; }","duration":"226.973387ms","start":"2026-07-21T05:29:14.256619Z","end":"2026-07-21T05:29:14.483593Z","steps":["trace[1876909135] 'process raft request' (duration: 226.713473ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T05:29:14.483977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.029008ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-07-21T05:29:14.484073Z","caller":"traceutil/trace.go:171","msg":"trace[859331846] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2726; }","duration":"163.21123ms","start":"2026-07-21T05:29:14.320842Z","end":"2026-07-21T05:29:14.484053Z","steps":["trace[859331846] 'agreement among raft nodes before linearized reading' (duration: 162.851185ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T05:32:55.533712Z","caller":"traceutil/trace.go:171","msg":"trace[466966611] transaction","detail":"{read_only:false; number_of_response:1; response_revision:4507; }","duration":"193.521209ms","start":"2026-07-21T05:32:55.340172Z","end":"2026-07-21T05:32:55.533694Z","steps":["trace[466966611] 'process raft request' (duration: 114.438273ms)","trace[466966611] 'compare' (duration: 78.959055ms)"],"step_count":2} {"level":"info","ts":"2026-07-21T05:33:06.041355Z","caller":"traceutil/trace.go:171","msg":"trace[402213620] linearizableReadLoop","detail":"{readStateIndex:4896; appliedIndex:4895; }","duration":"217.074691ms","start":"2026-07-21T05:33:05.824263Z","end":"2026-07-21T05:33:06.041338Z","steps":["trace[402213620] 'read index received' (duration: 216.976629ms)","trace[402213620] 'applied index is now lower than readState.Index' (duration: 97.072µs)"],"step_count":2} {"level":"info","ts":"2026-07-21T05:33:06.04142Z","caller":"traceutil/trace.go:171","msg":"trace[829662630] transaction","detail":"{read_only:false; response_revision:4715; number_of_response:1; }","duration":"251.915023ms","start":"2026-07-21T05:33:05.789473Z","end":"2026-07-21T05:33:06.041388Z","steps":["trace[829662630] 'process raft request' (duration: 251.720859ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T05:33:06.041513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.242393ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:1853"} {"level":"info","ts":"2026-07-21T05:33:06.041541Z","caller":"traceutil/trace.go:171","msg":"trace[1319943547] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4715; }","duration":"217.307895ms","start":"2026-07-21T05:33:05.824224Z","end":"2026-07-21T05:33:06.041532Z","steps":["trace[1319943547] 'agreement among raft nodes before linearized reading' (duration: 217.203653ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T05:33:06.067093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.775126ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-77c498fb-8099-4480-a5e2-6fc6de039c6c\" ","response":"range_response_count:1 size:3645"} {"level":"info","ts":"2026-07-21T05:33:06.067111Z","caller":"traceutil/trace.go:171","msg":"trace[1042121670] transaction","detail":"{read_only:false; response_revision:4716; number_of_response:1; }","duration":"185.82929ms","start":"2026-07-21T05:33:05.881249Z","end":"2026-07-21T05:33:06.067079Z","steps":["trace[1042121670] 'process raft request' (duration: 185.449425ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T05:33:06.067172Z","caller":"traceutil/trace.go:171","msg":"trace[1934906484] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-77c498fb-8099-4480-a5e2-6fc6de039c6c; range_end:; response_count:1; response_revision:4717; }","duration":"174.897869ms","start":"2026-07-21T05:33:05.892258Z","end":"2026-07-21T05:33:06.067156Z","steps":["trace[1934906484] 'agreement among raft nodes before linearized reading' (duration: 174.702136ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T05:33:06.067239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.953978ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-21T05:33:06.067324Z","caller":"traceutil/trace.go:171","msg":"trace[758316210] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:4717; }","duration":"222.107061ms","start":"2026-07-21T05:33:05.845198Z","end":"2026-07-21T05:33:06.067305Z","steps":["trace[758316210] 'agreement among raft nodes before linearized reading' (duration: 221.922518ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T05:33:06.257689Z","caller":"traceutil/trace.go:171","msg":"trace[1507937553] transaction","detail":"{read_only:false; response_revision:4722; number_of_response:1; }","duration":"103.178146ms","start":"2026-07-21T05:33:06.154477Z","end":"2026-07-21T05:33:06.257655Z","steps":["trace[1507937553] 'process raft request' (duration: 49.604756ms)","trace[1507937553] 'compare' (duration: 53.412918ms)"],"step_count":2} {"level":"info","ts":"2026-07-21T05:33:06.500067Z","caller":"traceutil/trace.go:171","msg":"trace[364053577] transaction","detail":"{read_only:false; response_revision:4724; number_of_response:1; }","duration":"235.172351ms","start":"2026-07-21T05:33:06.26486Z","end":"2026-07-21T05:33:06.500032Z","steps":["trace[364053577] 'process raft request' (duration: 219.208791ms)","trace[364053577] 'compare' (duration: 15.734707ms)"],"step_count":2} {"level":"info","ts":"2026-07-21T05:33:06.500159Z","caller":"traceutil/trace.go:171","msg":"trace[597124763] transaction","detail":"{read_only:false; response_revision:4725; number_of_response:1; }","duration":"235.016699ms","start":"2026-07-21T05:33:06.265112Z","end":"2026-07-21T05:33:06.500128Z","steps":["trace[597124763] 'process raft request' (duration: 234.827017ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T05:33:06.500364Z","caller":"traceutil/trace.go:171","msg":"trace[1808884407] transaction","detail":"{read_only:false; response_revision:4726; number_of_response:1; }","duration":"234.842505ms","start":"2026-07-21T05:33:06.265504Z","end":"2026-07-21T05:33:06.500347Z","steps":["trace[1808884407] 'process raft request' (duration: 234.506311ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T05:33:06.50067Z","caller":"traceutil/trace.go:171","msg":"trace[2055427076] linearizableReadLoop","detail":"{readStateIndex:4906; appliedIndex:4903; }","duration":"235.415404ms","start":"2026-07-21T05:33:06.26524Z","end":"2026-07-21T05:33:06.500655Z","steps":["trace[2055427076] 'read index received' (duration: 15.000078ms)","trace[2055427076] 'applied index is now lower than readState.Index' (duration: 220.414266ms)"],"step_count":2} {"level":"info","ts":"2026-07-21T05:33:06.500757Z","caller":"traceutil/trace.go:171","msg":"trace[921077939] transaction","detail":"{read_only:false; response_revision:4728; number_of_response:1; }","duration":"234.589574ms","start":"2026-07-21T05:33:06.26616Z","end":"2026-07-21T05:33:06.50075Z","steps":["trace[921077939] 'process raft request' (duration: 234.38495ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T05:33:06.500978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.725229ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:12973"} {"level":"info","ts":"2026-07-21T05:33:06.501004Z","caller":"traceutil/trace.go:171","msg":"trace[316121064] range","detail":"{range_begin:/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4728; }","duration":"235.77741ms","start":"2026-07-21T05:33:06.265219Z","end":"2026-07-21T05:33:06.500996Z","steps":["trace[316121064] 'agreement among raft nodes before linearized reading' (duration: 235.671528ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T05:33:06.501019Z","caller":"traceutil/trace.go:171","msg":"trace[1106550717] transaction","detail":"{read_only:false; response_revision:4727; number_of_response:1; }","duration":"235.431664ms","start":"2026-07-21T05:33:06.265569Z","end":"2026-07-21T05:33:06.501001Z","steps":["trace[1106550717] 'process raft request' (duration: 234.661283ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T05:33:06.526302Z","caller":"traceutil/trace.go:171","msg":"trace[481006878] transaction","detail":"{read_only:false; response_revision:4729; number_of_response:1; }","duration":"101.722177ms","start":"2026-07-21T05:33:06.424559Z","end":"2026-07-21T05:33:06.526281Z","steps":["trace[481006878] 'process raft request' (duration: 101.337621ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T05:33:06.526324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.372364ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/orders/\" range_end:\"/registry/acme.cert-manager.io/orders0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-21T05:33:06.526374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.936337ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"info","ts":"2026-07-21T05:33:06.526402Z","caller":"traceutil/trace.go:171","msg":"trace[120585344] range","detail":"{range_begin:/registry/acme.cert-manager.io/orders/; range_end:/registry/acme.cert-manager.io/orders0; response_count:0; response_revision:4729; }","duration":"128.529346ms","start":"2026-07-21T05:33:06.397852Z","end":"2026-07-21T05:33:06.526382Z","steps":["trace[120585344] 'agreement among raft nodes before linearized reading' (duration: 128.359514ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T05:33:06.526433Z","caller":"traceutil/trace.go:171","msg":"trace[203589582] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4729; }","duration":"261.007598ms","start":"2026-07-21T05:33:06.265407Z","end":"2026-07-21T05:33:06.526415Z","steps":["trace[203589582] 'agreement among raft nodes before linearized reading' (duration: 260.831475ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T05:33:21.450499Z","caller":"traceutil/trace.go:171","msg":"trace[585196915] linearizableReadLoop","detail":"{readStateIndex:5088; appliedIndex:5087; }","duration":"160.585284ms","start":"2026-07-21T05:33:21.289886Z","end":"2026-07-21T05:33:21.450471Z","steps":["trace[585196915] 'read index received' (duration: 117.937207ms)","trace[585196915] 'applied index is now lower than readState.Index' (duration: 42.646527ms)"],"step_count":2} {"level":"warn","ts":"2026-07-21T05:33:21.450815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.916888ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-07-21T05:33:21.45088Z","caller":"traceutil/trace.go:171","msg":"trace[1818544649] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4901; }","duration":"161.027249ms","start":"2026-07-21T05:33:21.289834Z","end":"2026-07-21T05:33:21.450861Z","steps":["trace[1818544649] 'agreement among raft nodes before linearized reading' (duration: 160.756376ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T05:33:21.451341Z","caller":"traceutil/trace.go:171","msg":"trace[1571665794] transaction","detail":"{read_only:false; response_revision:4901; number_of_response:1; }","duration":"216.521734ms","start":"2026-07-21T05:33:21.234792Z","end":"2026-07-21T05:33:21.451313Z","steps":["trace[1571665794] 'process raft request' (duration: 173.032206ms)","trace[1571665794] 'compare' (duration: 42.026839ms)"],"step_count":2} {"level":"warn","ts":"2026-07-21T05:33:21.849399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.242659ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-21T05:33:21.849541Z","caller":"traceutil/trace.go:171","msg":"trace[988651359] transaction","detail":"{read_only:false; response_revision:4902; number_of_response:1; }","duration":"393.01903ms","start":"2026-07-21T05:33:21.456496Z","end":"2026-07-21T05:33:21.849515Z","steps":["trace[988651359] 'process raft request' (duration: 158.574217ms)","trace[988651359] 'compare' (duration: 234.070057ms)"],"step_count":2} {"level":"warn","ts":"2026-07-21T05:33:21.849643Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T05:33:21.456471Z","time spent":"393.121571ms","remote":"127.0.0.1:59732","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":893,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-21T05:33:21.89306Z","caller":"traceutil/trace.go:171","msg":"trace[1629942600] transaction","detail":"{read_only:false; response_revision:4903; number_of_response:1; }","duration":"435.516775ms","start":"2026-07-21T05:33:21.457519Z","end":"2026-07-21T05:33:21.893035Z","steps":["trace[1629942600] 'process raft request' (duration: 435.341163ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T05:33:21.893125Z","caller":"traceutil/trace.go:171","msg":"trace[579067978] linearizableReadLoop","detail":"{readStateIndex:5090; appliedIndex:5088; }","duration":"435.511345ms","start":"2026-07-21T05:33:21.457599Z","end":"2026-07-21T05:33:21.89311Z","steps":["trace[579067978] 'read index received' (duration: 157.472501ms)","trace[579067978] 'applied index is now lower than readState.Index' (duration: 278.038034ms)"],"step_count":2} {"level":"warn","ts":"2026-07-21T05:33:21.8932Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T05:33:21.45751Z","time spent":"435.619936ms","remote":"127.0.0.1:59732","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":951,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-21T05:33:21.893398Z","caller":"traceutil/trace.go:171","msg":"trace[1590656019] transaction","detail":"{read_only:false; response_revision:4904; number_of_response:1; }","duration":"435.690668ms","start":"2026-07-21T05:33:21.457695Z","end":"2026-07-21T05:33:21.893386Z","steps":["trace[1590656019] 'process raft request' (duration: 435.281072ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T05:33:21.893466Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T05:33:21.457687Z","time spent":"435.737748ms","remote":"127.0.0.1:59840","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1506,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-21T05:33:21.893582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"435.979431ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-77c498fb-8099-4480-a5e2-6fc6de039c6c\" ","response":"range_response_count:1 size:1322"} {"level":"info","ts":"2026-07-21T05:33:21.893617Z","caller":"traceutil/trace.go:171","msg":"trace[492578260] range","detail":"{range_begin:/registry/persistentvolumes/pvc-77c498fb-8099-4480-a5e2-6fc6de039c6c; range_end:; response_count:1; response_revision:4906; }","duration":"436.047923ms","start":"2026-07-21T05:33:21.457559Z","end":"2026-07-21T05:33:21.893607Z","steps":["trace[492578260] 'agreement among raft nodes before linearized reading' (duration: 435.932961ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T05:33:21.893652Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T05:33:21.457542Z","time spent":"436.101083ms","remote":"127.0.0.1:59710","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":1345,"request content":"key:\"/registry/persistentvolumes/pvc-77c498fb-8099-4480-a5e2-6fc6de039c6c\" "} {"level":"warn","ts":"2026-07-21T05:33:21.893761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"386.719152ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-21T05:33:21.893798Z","caller":"traceutil/trace.go:171","msg":"trace[1995299163] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4906; }","duration":"386.785543ms","start":"2026-07-21T05:33:21.507002Z","end":"2026-07-21T05:33:21.893787Z","steps":["trace[1995299163] 'agreement among raft nodes before linearized reading' (duration: 386.700262ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T05:33:21.893811Z","caller":"traceutil/trace.go:171","msg":"trace[1449555493] transaction","detail":"{read_only:false; response_revision:4906; number_of_response:1; }","duration":"376.116016ms","start":"2026-07-21T05:33:21.517685Z","end":"2026-07-21T05:33:21.893801Z","steps":["trace[1449555493] 'process raft request' (duration: 375.382516ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T05:33:21.893826Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T05:33:21.506983Z","time spent":"386.836704ms","remote":"127.0.0.1:59532","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-21T05:33:21.893869Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T05:33:21.517672Z","time spent":"376.164857ms","remote":"127.0.0.1:59826","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-21T05:33:21.893979Z","caller":"traceutil/trace.go:171","msg":"trace[143905803] transaction","detail":"{read_only:false; response_revision:4905; number_of_response:1; }","duration":"436.226614ms","start":"2026-07-21T05:33:21.457722Z","end":"2026-07-21T05:33:21.893949Z","steps":["trace[143905803] 'process raft request' (duration: 435.311092ms)"],"step_count":1} {"level":"warn","ts":"2026-07-21T05:33:21.894127Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-21T05:33:21.457711Z","time spent":"436.332376ms","remote":"127.0.0.1:59840","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1429,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-21T05:33:22.10295Z","caller":"traceutil/trace.go:171","msg":"trace[887209656] linearizableReadLoop","detail":"{readStateIndex:5094; appliedIndex:5093; }","duration":"169.057801ms","start":"2026-07-21T05:33:21.933872Z","end":"2026-07-21T05:33:22.10293Z","steps":["trace[887209656] 'read index received' (duration: 158.188971ms)","trace[887209656] 'applied index is now lower than readState.Index' (duration: 10.86809ms)"],"step_count":2} {"level":"warn","ts":"2026-07-21T05:33:22.103166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.273274ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:1453"} {"level":"info","ts":"2026-07-21T05:33:22.103131Z","caller":"traceutil/trace.go:171","msg":"trace[1750701192] transaction","detail":"{read_only:false; response_revision:4907; number_of_response:1; }","duration":"169.636738ms","start":"2026-07-21T05:33:21.933469Z","end":"2026-07-21T05:33:22.103106Z","steps":["trace[1750701192] 'process raft request' (duration: 158.619526ms)","trace[1750701192] 'compare' (duration: 10.693898ms)"],"step_count":2} {"level":"info","ts":"2026-07-21T05:33:22.103216Z","caller":"traceutil/trace.go:171","msg":"trace[345695158] range","detail":"{range_begin:/registry/services/specs/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:4907; }","duration":"169.359215ms","start":"2026-07-21T05:33:21.933846Z","end":"2026-07-21T05:33:22.103205Z","steps":["trace[345695158] 'agreement among raft nodes before linearized reading' (duration: 169.165002ms)"],"step_count":1} {"level":"info","ts":"2026-07-21T05:34:45.029581Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2887} {"level":"info","ts":"2026-07-21T05:34:45.119968Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2887,"took":"88.979753ms","hash":3434072955,"current-db-size-bytes":53964800,"current-db-size":"54 MB","current-db-size-in-use-bytes":29261824,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-07-21T05:34:45.120053Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3434072955,"revision":2887,"compact-revision":-1}