{"level":"warn","ts":"2026-04-20T02:24:10.153529Z","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-20T02:24:10.153618Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.3:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.3:2380","--initial-cluster=instance=https://199.204.45.3:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.3:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.3: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-20T02:24:10.153685Z","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-20T02:24:10.153697Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.3:2380"]}
{"level":"info","ts":"2026-04-20T02:24:10.153712Z","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-20T02:24:10.154322Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.3:2379"]}
{"level":"info","ts":"2026-04-20T02:24:10.154408Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.3:2380"],"listen-peer-urls":["https://199.204.45.3:2380"],"advertise-client-urls":["https://199.204.45.3:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.3:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.3: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-20T02:24:10.160174Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.538721ms"}
{"level":"info","ts":"2026-04-20T02:24:10.16978Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"597401b06ce1cf3d","cluster-id":"dfc54657ad8a2432"}
{"level":"info","ts":"2026-04-20T02:24:10.169862Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d switched to configuration voters=()"}
{"level":"info","ts":"2026-04-20T02:24:10.169882Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d became follower at term 0"}
{"level":"info","ts":"2026-04-20T02:24:10.169901Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 597401b06ce1cf3d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-04-20T02:24:10.169913Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d became follower at term 1"}
{"level":"info","ts":"2026-04-20T02:24:10.169957Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d switched to configuration voters=(6445778823926632253)"}
{"level":"warn","ts":"2026-04-20T02:24:10.179354Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-04-20T02:24:10.181031Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-04-20T02:24:10.182415Z","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-20T02:24:10.185342Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"597401b06ce1cf3d","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-04-20T02:24:10.188662Z","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-20T02:24:10.188842Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"597401b06ce1cf3d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-04-20T02:24:10.188891Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.3:2380"}
{"level":"info","ts":"2026-04-20T02:24:10.188965Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.3:2380"}
{"level":"info","ts":"2026-04-20T02:24:10.188722Z","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-20T02:24:10.18907Z","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-20T02:24:10.189101Z","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-20T02:24:10.191267Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"597401b06ce1cf3d","initial-advertise-peer-urls":["https://199.204.45.3:2380"],"listen-peer-urls":["https://199.204.45.3:2380"],"advertise-client-urls":["https://199.204.45.3:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.3:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-04-20T02:24:10.191297Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d switched to configuration voters=(6445778823926632253)"}
{"level":"info","ts":"2026-04-20T02:24:10.191354Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-04-20T02:24:10.191531Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"dfc54657ad8a2432","local-member-id":"597401b06ce1cf3d","added-peer-id":"597401b06ce1cf3d","added-peer-peer-urls":["https://199.204.45.3:2380"]}
{"level":"info","ts":"2026-04-20T02:24:10.670491Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d is starting a new election at term 1"}
{"level":"info","ts":"2026-04-20T02:24:10.670532Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d became pre-candidate at term 1"}
{"level":"info","ts":"2026-04-20T02:24:10.670555Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d received MsgPreVoteResp from 597401b06ce1cf3d at term 1"}
{"level":"info","ts":"2026-04-20T02:24:10.670566Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d became candidate at term 2"}
{"level":"info","ts":"2026-04-20T02:24:10.670571Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d received MsgVoteResp from 597401b06ce1cf3d at term 2"}
{"level":"info","ts":"2026-04-20T02:24:10.670579Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d became leader at term 2"}
{"level":"info","ts":"2026-04-20T02:24:10.670587Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 597401b06ce1cf3d elected leader 597401b06ce1cf3d at term 2"}
{"level":"info","ts":"2026-04-20T02:24:10.672809Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-20T02:24:10.675053Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"597401b06ce1cf3d","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.3:2379]}","request-path":"/0/members/597401b06ce1cf3d/attributes","cluster-id":"dfc54657ad8a2432","publish-timeout":"7s"}
{"level":"info","ts":"2026-04-20T02:24:10.67524Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-04-20T02:24:10.675393Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-04-20T02:24:10.677031Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"dfc54657ad8a2432","local-member-id":"597401b06ce1cf3d","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-20T02:24:10.677127Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-20T02:24:10.67715Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-20T02:24:10.678379Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.3:2379"}
{"level":"info","ts":"2026-04-20T02:24:10.678505Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-04-20T02:24:10.678527Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-04-20T02:24:10.678856Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-04-20T02:24:42.566983Z","caller":"traceutil/trace.go:171","msg":"trace[1063488957] linearizableReadLoop","detail":"{readStateIndex:581; appliedIndex:580; }","duration":"132.416755ms","start":"2026-04-20T02:24:42.434538Z","end":"2026-04-20T02:24:42.566955Z","steps":["trace[1063488957] 'read index received'  (duration: 131.590723ms)","trace[1063488957] 'applied index is now lower than readState.Index'  (duration: 825.152µs)"],"step_count":2}
{"level":"warn","ts":"2026-04-20T02:24:42.567264Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.713105ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-04-20T02:24:42.567335Z","caller":"traceutil/trace.go:171","msg":"trace[337916332] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:561; }","duration":"132.841568ms","start":"2026-04-20T02:24:42.434481Z","end":"2026-04-20T02:24:42.567322Z","steps":["trace[337916332] 'agreement among raft nodes before linearized reading'  (duration: 132.597751ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:24:42.56755Z","caller":"traceutil/trace.go:171","msg":"trace[2093426087] transaction","detail":"{read_only:false; response_revision:561; number_of_response:1; }","duration":"276.26326ms","start":"2026-04-20T02:24:42.291277Z","end":"2026-04-20T02:24:42.56754Z","steps":["trace[2093426087] 'process raft request'  (duration: 275.152809ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:24:43.833188Z","caller":"traceutil/trace.go:171","msg":"trace[401977815] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"116.467136ms","start":"2026-04-20T02:24:43.716688Z","end":"2026-04-20T02:24:43.833155Z","steps":["trace[401977815] 'process raft request'  (duration: 116.276221ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:24:56.986321Z","caller":"traceutil/trace.go:171","msg":"trace[1692248085] transaction","detail":"{read_only:false; response_revision:721; number_of_response:1; }","duration":"297.44342ms","start":"2026-04-20T02:24:56.688853Z","end":"2026-04-20T02:24:56.986296Z","steps":["trace[1692248085] 'process raft request'  (duration: 297.280075ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:25:33.064359Z","caller":"traceutil/trace.go:171","msg":"trace[580483239] transaction","detail":"{read_only:false; response_revision:941; number_of_response:1; }","duration":"250.468594ms","start":"2026-04-20T02:25:32.813866Z","end":"2026-04-20T02:25:33.064334Z","steps":["trace[580483239] 'process raft request'  (duration: 250.298519ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:28:35.886096Z","caller":"traceutil/trace.go:171","msg":"trace[1291263068] transaction","detail":"{read_only:false; response_revision:1857; number_of_response:1; }","duration":"118.46158ms","start":"2026-04-20T02:28:35.767615Z","end":"2026-04-20T02:28:35.886077Z","steps":["trace[1291263068] 'process raft request'  (duration: 118.118632ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:28:35.995931Z","caller":"traceutil/trace.go:171","msg":"trace[1334465028] transaction","detail":"{read_only:false; response_revision:1859; number_of_response:1; }","duration":"159.816305ms","start":"2026-04-20T02:28:35.835493Z","end":"2026-04-20T02:28:35.995309Z","steps":["trace[1334465028] 'process raft request'  (duration: 159.650421ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:28:35.995969Z","caller":"traceutil/trace.go:171","msg":"trace[949070857] transaction","detail":"{read_only:false; response_revision:1858; number_of_response:1; }","duration":"172.832333ms","start":"2026-04-20T02:28:35.822421Z","end":"2026-04-20T02:28:35.995253Z","steps":["trace[949070857] 'process raft request'  (duration: 136.663305ms)","trace[949070857] 'compare'  (duration: 35.639175ms)"],"step_count":2}
{"level":"info","ts":"2026-04-20T02:28:35.995369Z","caller":"traceutil/trace.go:171","msg":"trace[1274961833] linearizableReadLoop","detail":"{readStateIndex:1934; appliedIndex:1932; }","duration":"170.698134ms","start":"2026-04-20T02:28:35.824644Z","end":"2026-04-20T02:28:35.995342Z","steps":["trace[1274961833] 'read index received'  (duration: 60.964993ms)","trace[1274961833] 'applied index is now lower than readState.Index'  (duration: 109.730401ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-20T02:28:35.997077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.669822ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-20T02:28:35.997164Z","caller":"traceutil/trace.go:171","msg":"trace[512363417] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:1861; }","duration":"131.819045ms","start":"2026-04-20T02:28:35.865323Z","end":"2026-04-20T02:28:35.997142Z","steps":["trace[512363417] 'agreement among raft nodes before linearized reading'  (duration: 131.307204ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:28:35.997236Z","caller":"traceutil/trace.go:171","msg":"trace[1480615459] transaction","detail":"{read_only:false; response_revision:1860; number_of_response:1; }","duration":"159.57272ms","start":"2026-04-20T02:28:35.835736Z","end":"2026-04-20T02:28:35.995309Z","steps":["trace[1480615459] 'process raft request'  (duration: 159.484268ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:28:35.999431Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.762077ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/ingress-nginx/ingress-nginx-admission\" ","response":"range_response_count:1 size:1071"}
{"level":"info","ts":"2026-04-20T02:28:35.999573Z","caller":"traceutil/trace.go:171","msg":"trace[344697204] range","detail":"{range_begin:/registry/serviceaccounts/ingress-nginx/ingress-nginx-admission; range_end:; response_count:1; response_revision:1861; }","duration":"174.957831ms","start":"2026-04-20T02:28:35.82458Z","end":"2026-04-20T02:28:35.999537Z","steps":["trace[344697204] 'agreement among raft nodes before linearized reading'  (duration: 174.545592ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:28:36.29657Z","caller":"traceutil/trace.go:171","msg":"trace[659044484] transaction","detail":"{read_only:false; response_revision:1898; number_of_response:1; }","duration":"116.31146ms","start":"2026-04-20T02:28:36.180214Z","end":"2026-04-20T02:28:36.296526Z","steps":["trace[659044484] 'process raft request'  (duration: 58.067268ms)","trace[659044484] 'compare'  (duration: 57.998287ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-20T02:28:36.296762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.035517ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-20T02:28:36.29684Z","caller":"traceutil/trace.go:171","msg":"trace[1026469271] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1898; }","duration":"128.197881ms","start":"2026-04-20T02:28:36.168621Z","end":"2026-04-20T02:28:36.296819Z","steps":["trace[1026469271] 'agreement among raft nodes before linearized reading'  (duration: 128.050537ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:28:36.36239Z","caller":"traceutil/trace.go:171","msg":"trace[1974285725] transaction","detail":"{read_only:false; response_revision:1899; number_of_response:1; }","duration":"153.191575ms","start":"2026-04-20T02:28:36.209176Z","end":"2026-04-20T02:28:36.362368Z","steps":["trace[1974285725] 'process raft request'  (duration: 152.964469ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:28:36.362643Z","caller":"traceutil/trace.go:171","msg":"trace[83278177] transaction","detail":"{read_only:false; response_revision:1901; number_of_response:1; }","duration":"147.865982ms","start":"2026-04-20T02:28:36.214721Z","end":"2026-04-20T02:28:36.362587Z","steps":["trace[83278177] 'process raft request'  (duration: 147.593396ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:28:36.362735Z","caller":"traceutil/trace.go:171","msg":"trace[289433632] transaction","detail":"{read_only:false; response_revision:1905; number_of_response:1; }","duration":"127.668391ms","start":"2026-04-20T02:28:36.235023Z","end":"2026-04-20T02:28:36.362692Z","steps":["trace[289433632] 'process raft request'  (duration: 127.482277ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:28:36.362819Z","caller":"traceutil/trace.go:171","msg":"trace[1794913439] transaction","detail":"{read_only:false; response_revision:1908; number_of_response:1; }","duration":"127.23295ms","start":"2026-04-20T02:28:36.235578Z","end":"2026-04-20T02:28:36.362811Z","steps":["trace[1794913439] 'process raft request'  (duration: 127.025256ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:28:36.362744Z","caller":"traceutil/trace.go:171","msg":"trace[449943135] transaction","detail":"{read_only:false; response_revision:1900; number_of_response:1; }","duration":"148.19858ms","start":"2026-04-20T02:28:36.214483Z","end":"2026-04-20T02:28:36.362682Z","steps":["trace[449943135] 'process raft request'  (duration: 147.78057ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:28:36.36286Z","caller":"traceutil/trace.go:171","msg":"trace[914626573] transaction","detail":"{read_only:false; response_revision:1903; number_of_response:1; }","duration":"128.429647ms","start":"2026-04-20T02:28:36.234372Z","end":"2026-04-20T02:28:36.362801Z","steps":["trace[914626573] 'process raft request'  (duration: 128.065409ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:28:36.362713Z","caller":"traceutil/trace.go:171","msg":"trace[1870610642] transaction","detail":"{read_only:false; response_revision:1909; number_of_response:1; }","duration":"127.048567ms","start":"2026-04-20T02:28:36.235643Z","end":"2026-04-20T02:28:36.362691Z","steps":["trace[1870610642] 'process raft request'  (duration: 126.986535ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:28:36.362941Z","caller":"traceutil/trace.go:171","msg":"trace[78892293] transaction","detail":"{read_only:false; response_revision:1904; number_of_response:1; }","duration":"128.021408ms","start":"2026-04-20T02:28:36.234907Z","end":"2026-04-20T02:28:36.362928Z","steps":["trace[78892293] 'process raft request'  (duration: 127.569268ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:28:36.362894Z","caller":"traceutil/trace.go:171","msg":"trace[1067710669] transaction","detail":"{read_only:false; response_revision:1907; number_of_response:1; }","duration":"127.506226ms","start":"2026-04-20T02:28:36.235299Z","end":"2026-04-20T02:28:36.362805Z","steps":["trace[1067710669] 'process raft request'  (duration: 127.267721ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:28:36.363021Z","caller":"traceutil/trace.go:171","msg":"trace[428953391] transaction","detail":"{read_only:false; response_revision:1902; number_of_response:1; }","duration":"139.572682ms","start":"2026-04-20T02:28:36.223119Z","end":"2026-04-20T02:28:36.362692Z","steps":["trace[428953391] 'process raft request'  (duration: 139.283875ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:28:36.362769Z","caller":"traceutil/trace.go:171","msg":"trace[1980730159] transaction","detail":"{read_only:false; response_revision:1906; number_of_response:1; }","duration":"127.631819ms","start":"2026-04-20T02:28:36.235126Z","end":"2026-04-20T02:28:36.362758Z","steps":["trace[1980730159] 'process raft request'  (duration: 127.407254ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:28:36.363089Z","caller":"traceutil/trace.go:171","msg":"trace[786718832] transaction","detail":"{read_only:false; response_revision:1910; number_of_response:1; }","duration":"127.368573ms","start":"2026-04-20T02:28:36.235704Z","end":"2026-04-20T02:28:36.363073Z","steps":["trace[786718832] 'process raft request'  (duration: 126.958084ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:28:36.363142Z","caller":"traceutil/trace.go:171","msg":"trace[148694893] transaction","detail":"{read_only:false; response_revision:1911; number_of_response:1; }","duration":"127.153238ms","start":"2026-04-20T02:28:36.235951Z","end":"2026-04-20T02:28:36.363104Z","steps":["trace[148694893] 'process raft request'  (duration: 127.012855ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:28:36.363148Z","caller":"traceutil/trace.go:171","msg":"trace[1819491284] transaction","detail":"{read_only:false; response_revision:1913; number_of_response:1; }","duration":"128.09608ms","start":"2026-04-20T02:28:36.235041Z","end":"2026-04-20T02:28:36.363137Z","steps":["trace[1819491284] 'process raft request'  (duration: 128.031298ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:28:36.36322Z","caller":"traceutil/trace.go:171","msg":"trace[65653285] transaction","detail":"{read_only:false; response_revision:1914; number_of_response:1; }","duration":"126.649126ms","start":"2026-04-20T02:28:36.236514Z","end":"2026-04-20T02:28:36.363163Z","steps":["trace[65653285] 'process raft request'  (duration: 126.584435ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:28:36.363234Z","caller":"traceutil/trace.go:171","msg":"trace[941194345] transaction","detail":"{read_only:false; response_revision:1912; number_of_response:1; }","duration":"127.23353ms","start":"2026-04-20T02:28:36.235938Z","end":"2026-04-20T02:28:36.363171Z","steps":["trace[941194345] 'process raft request'  (duration: 127.103277ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:28:36.363417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.633813ms","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-04-20T02:28:36.363455Z","caller":"traceutil/trace.go:171","msg":"trace[2025120242] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1914; }","duration":"118.721025ms","start":"2026-04-20T02:28:36.244723Z","end":"2026-04-20T02:28:36.363444Z","steps":["trace[2025120242] 'agreement among raft nodes before linearized reading'  (duration: 118.453279ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:28:43.544369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.238021ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14933265287327370169 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:2062 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-20T02:28:43.544541Z","caller":"traceutil/trace.go:171","msg":"trace[1956505136] transaction","detail":"{read_only:false; response_revision:2094; number_of_response:1; }","duration":"440.187877ms","start":"2026-04-20T02:28:43.104326Z","end":"2026-04-20T02:28:43.544514Z","steps":["trace[1956505136] 'process raft request'  (duration: 200.384223ms)","trace[1956505136] 'compare'  (duration: 239.133759ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-20T02:28:43.544701Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:28:43.1043Z","time spent":"440.320431ms","remote":"127.0.0.1:46966","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:2062 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-04-20T02:28:56.961039Z","caller":"traceutil/trace.go:171","msg":"trace[1449866129] transaction","detail":"{read_only:false; response_revision:2337; number_of_response:1; }","duration":"295.540353ms","start":"2026-04-20T02:28:56.665474Z","end":"2026-04-20T02:28:56.961014Z","steps":["trace[1449866129] 'process raft request'  (duration: 295.301027ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:28:57.022839Z","caller":"traceutil/trace.go:171","msg":"trace[14820928] transaction","detail":"{read_only:false; response_revision:2338; number_of_response:1; }","duration":"328.828329ms","start":"2026-04-20T02:28:56.693991Z","end":"2026-04-20T02:28:57.02282Z","steps":["trace[14820928] 'process raft request'  (duration: 328.194665ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:28:57.022963Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:28:56.693975Z","time spent":"328.921921ms","remote":"127.0.0.1:46966","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:2314 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"warn","ts":"2026-04-20T02:29:16.444243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.059872ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14933265287327370957 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/ingress-nginx/ingress-nginx-controller-jjfvj.18a7efb9085616a0\" mod_revision:0 > success:<request_put:<key:\"/registry/events/ingress-nginx/ingress-nginx-controller-jjfvj.18a7efb9085616a0\" value_size:654 lease:5709893250472593428 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-04-20T02:29:16.444395Z","caller":"traceutil/trace.go:171","msg":"trace[1843109044] linearizableReadLoop","detail":"{readStateIndex:2549; appliedIndex:2548; }","duration":"318.223374ms","start":"2026-04-20T02:29:16.126147Z","end":"2026-04-20T02:29:16.44437Z","steps":["trace[1843109044] 'read index received'  (duration: 125.836725ms)","trace[1843109044] 'applied index is now lower than readState.Index'  (duration: 192.381259ms)"],"step_count":2}
{"level":"info","ts":"2026-04-20T02:29:16.44451Z","caller":"traceutil/trace.go:171","msg":"trace[1480432679] transaction","detail":"{read_only:false; response_revision:2462; number_of_response:1; }","duration":"433.545307ms","start":"2026-04-20T02:29:16.010953Z","end":"2026-04-20T02:29:16.444499Z","steps":["trace[1480432679] 'process raft request'  (duration: 241.114987ms)","trace[1480432679] 'compare'  (duration: 191.737024ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-20T02:29:16.444584Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:29:16.010925Z","time spent":"433.615408ms","remote":"127.0.0.1:46800","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":750,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/events/ingress-nginx/ingress-nginx-controller-jjfvj.18a7efb9085616a0\" mod_revision:0 > success:<request_put:<key:\"/registry/events/ingress-nginx/ingress-nginx-controller-jjfvj.18a7efb9085616a0\" value_size:654 lease:5709893250472593428 >> failure:<>"}
{"level":"warn","ts":"2026-04-20T02:29:16.444651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.48834ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-04-20T02:29:16.444714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.551389ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-04-20T02:29:16.444782Z","caller":"traceutil/trace.go:171","msg":"trace[787770703] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2462; }","duration":"209.666552ms","start":"2026-04-20T02:29:16.235102Z","end":"2026-04-20T02:29:16.444768Z","steps":["trace[787770703] 'agreement among raft nodes before linearized reading'  (duration: 209.426577ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:29:16.444807Z","caller":"traceutil/trace.go:171","msg":"trace[1342909890] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2462; }","duration":"318.674324ms","start":"2026-04-20T02:29:16.12609Z","end":"2026-04-20T02:29:16.444764Z","steps":["trace[1342909890] 'agreement among raft nodes before linearized reading'  (duration: 318.437378ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:29:16.444852Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:29:16.126063Z","time spent":"318.779316ms","remote":"127.0.0.1:46728","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-04-20T02:29:39.337093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.31832ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14933265287327372004 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/secrets/openstack/libvirt-vnc-ca-bt9bk\" mod_revision:2988 > success:<request_delete_range:<key:\"/registry/secrets/openstack/libvirt-vnc-ca-bt9bk\" > > failure:<request_range:<key:\"/registry/secrets/openstack/libvirt-vnc-ca-bt9bk\" > >>","response":"size:18"}
{"level":"info","ts":"2026-04-20T02:29:39.337303Z","caller":"traceutil/trace.go:171","msg":"trace[2113576978] transaction","detail":"{read_only:false; response_revision:3024; number_of_response:1; }","duration":"109.271999ms","start":"2026-04-20T02:29:39.228013Z","end":"2026-04-20T02:29:39.337285Z","steps":["trace[2113576978] 'process raft request'  (duration: 109.203768ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:29:39.337606Z","caller":"traceutil/trace.go:171","msg":"trace[94845852] transaction","detail":"{read_only:false; number_of_response:1; response_revision:3023; }","duration":"158.712063ms","start":"2026-04-20T02:29:39.178856Z","end":"2026-04-20T02:29:39.337568Z","steps":["trace[94845852] 'compare'  (duration: 146.182287ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:29:39.737114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.786783ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14933265287327372013 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/cert-manager.io/certificates/openstack/libvirt-api-ca\" mod_revision:3028 > success:<request_put:<key:\"/registry/cert-manager.io/certificates/openstack/libvirt-api-ca\" value_size:1449 >> failure:<request_range:<key:\"/registry/cert-manager.io/certificates/openstack/libvirt-api-ca\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-20T02:29:39.737339Z","caller":"traceutil/trace.go:171","msg":"trace[665120950] linearizableReadLoop","detail":"{readStateIndex:3160; appliedIndex:3158; }","duration":"167.863765ms","start":"2026-04-20T02:29:39.569452Z","end":"2026-04-20T02:29:39.737316Z","steps":["trace[665120950] 'read index received'  (duration: 144.728263ms)","trace[665120950] 'applied index is now lower than readState.Index'  (duration: 23.133872ms)"],"step_count":2}
{"level":"info","ts":"2026-04-20T02:29:39.737388Z","caller":"traceutil/trace.go:171","msg":"trace[31117656] transaction","detail":"{read_only:false; response_revision:3030; number_of_response:1; }","duration":"305.734398ms","start":"2026-04-20T02:29:39.431599Z","end":"2026-04-20T02:29:39.737333Z","steps":["trace[31117656] 'process raft request'  (duration: 72.618968ms)","trace[31117656] 'compare'  (duration: 232.631239ms)"],"step_count":2}
{"level":"info","ts":"2026-04-20T02:29:39.737488Z","caller":"traceutil/trace.go:171","msg":"trace[381013986] transaction","detail":"{read_only:false; number_of_response:1; response_revision:3030; }","duration":"251.783293ms","start":"2026-04-20T02:29:39.485689Z","end":"2026-04-20T02:29:39.737472Z","steps":["trace[381013986] 'process raft request'  (duration: 251.579568ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:29:39.737639Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:29:39.43157Z","time spent":"305.923453ms","remote":"127.0.0.1:34776","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1520,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/cert-manager.io/certificates/openstack/libvirt-api-ca\" mod_revision:3028 > success:<request_put:<key:\"/registry/cert-manager.io/certificates/openstack/libvirt-api-ca\" value_size:1449 >> failure:<request_range:<key:\"/registry/cert-manager.io/certificates/openstack/libvirt-api-ca\" > >"}
{"level":"warn","ts":"2026-04-20T02:29:39.737947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.400517ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-6a933342-de66-406a-83bf-cbdb1dc6146f\" ","response":"range_response_count:1 size:3599"}
{"level":"info","ts":"2026-04-20T02:29:39.738028Z","caller":"traceutil/trace.go:171","msg":"trace[321471386] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-6a933342-de66-406a-83bf-cbdb1dc6146f; range_end:; response_count:1; response_revision:3030; }","duration":"144.528699ms","start":"2026-04-20T02:29:39.59348Z","end":"2026-04-20T02:29:39.738008Z","steps":["trace[321471386] 'agreement among raft nodes before linearized reading'  (duration: 144.230823ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:29:39.738138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.609272ms","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-20T02:29:39.738204Z","caller":"traceutil/trace.go:171","msg":"trace[414298627] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:3030; }","duration":"168.794976ms","start":"2026-04-20T02:29:39.569392Z","end":"2026-04-20T02:29:39.738187Z","steps":["trace[414298627] 'agreement among raft nodes before linearized reading'  (duration: 168.52781ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:29:39.739893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.479347ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/openstack/\" range_end:\"/registry/secrets/openstack0\" ","response":"range_response_count:13 size:322458"}
{"level":"info","ts":"2026-04-20T02:29:39.739998Z","caller":"traceutil/trace.go:171","msg":"trace[2101180562] range","detail":"{range_begin:/registry/secrets/openstack/; range_end:/registry/secrets/openstack0; response_count:13; response_revision:3030; }","duration":"106.63585ms","start":"2026-04-20T02:29:39.63334Z","end":"2026-04-20T02:29:39.739976Z","steps":["trace[2101180562] 'agreement among raft nodes before linearized reading'  (duration: 104.570245ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:29:39.938967Z","caller":"traceutil/trace.go:171","msg":"trace[718386138] transaction","detail":"{read_only:false; response_revision:3031; number_of_response:1; }","duration":"196.317326ms","start":"2026-04-20T02:29:39.742615Z","end":"2026-04-20T02:29:39.938932Z","steps":["trace[718386138] 'process raft request'  (duration: 171.60707ms)","trace[718386138] 'compare'  (duration: 24.512872ms)"],"step_count":2}
{"level":"info","ts":"2026-04-20T02:29:39.975546Z","caller":"traceutil/trace.go:171","msg":"trace[1493784734] linearizableReadLoop","detail":"{readStateIndex:3164; appliedIndex:3160; }","duration":"106.17682ms","start":"2026-04-20T02:29:39.869336Z","end":"2026-04-20T02:29:39.975513Z","steps":["trace[1493784734] 'read index received'  (duration: 44.860773ms)","trace[1493784734] 'applied index is now lower than readState.Index'  (duration: 61.314807ms)"],"step_count":2}
{"level":"info","ts":"2026-04-20T02:29:39.975695Z","caller":"traceutil/trace.go:171","msg":"trace[890383241] transaction","detail":"{read_only:false; response_revision:3034; number_of_response:1; }","duration":"224.108781ms","start":"2026-04-20T02:29:39.751574Z","end":"2026-04-20T02:29:39.975683Z","steps":["trace[890383241] 'process raft request'  (duration: 223.756492ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:29:39.975895Z","caller":"traceutil/trace.go:171","msg":"trace[856657195] transaction","detail":"{read_only:false; response_revision:3032; number_of_response:1; }","duration":"231.588946ms","start":"2026-04-20T02:29:39.744275Z","end":"2026-04-20T02:29:39.975864Z","steps":["trace[856657195] 'process raft request'  (duration: 230.788448ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:29:39.976273Z","caller":"traceutil/trace.go:171","msg":"trace[486857692] transaction","detail":"{read_only:false; response_revision:3033; number_of_response:1; }","duration":"229.719085ms","start":"2026-04-20T02:29:39.74654Z","end":"2026-04-20T02:29:39.976259Z","steps":["trace[486857692] 'process raft request'  (duration: 228.722222ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:29:39.976343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.982838ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"}
{"level":"info","ts":"2026-04-20T02:29:39.976396Z","caller":"traceutil/trace.go:171","msg":"trace[398777345] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:3035; }","duration":"107.11687ms","start":"2026-04-20T02:29:39.869266Z","end":"2026-04-20T02:29:39.976383Z","steps":["trace[398777345] 'agreement among raft nodes before linearized reading'  (duration: 106.928086ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:29:40.283789Z","caller":"traceutil/trace.go:171","msg":"trace[1243252550] linearizableReadLoop","detail":"{readStateIndex:3169; appliedIndex:3168; }","duration":"157.18722ms","start":"2026-04-20T02:29:40.126575Z","end":"2026-04-20T02:29:40.283762Z","steps":["trace[1243252550] 'read index received'  (duration: 143.548408ms)","trace[1243252550] 'applied index is now lower than readState.Index'  (duration: 13.636952ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-20T02:29:40.283976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.385524ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-20T02:29:40.284058Z","caller":"traceutil/trace.go:171","msg":"trace[1645620983] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:3039; }","duration":"157.536077ms","start":"2026-04-20T02:29:40.126503Z","end":"2026-04-20T02:29:40.284039Z","steps":["trace[1645620983] 'agreement among raft nodes before linearized reading'  (duration: 157.385234ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:29:40.284269Z","caller":"traceutil/trace.go:171","msg":"trace[1941310560] transaction","detail":"{read_only:false; response_revision:3039; number_of_response:1; }","duration":"246.254141ms","start":"2026-04-20T02:29:40.03759Z","end":"2026-04-20T02:29:40.283845Z","steps":["trace[1941310560] 'process raft request'  (duration: 232.548368ms)","trace[1941310560] 'compare'  (duration: 13.443136ms)"],"step_count":2}
{"level":"info","ts":"2026-04-20T02:29:50.637665Z","caller":"traceutil/trace.go:171","msg":"trace[1701410074] transaction","detail":"{read_only:false; response_revision:3332; number_of_response:1; }","duration":"138.19074ms","start":"2026-04-20T02:29:50.499448Z","end":"2026-04-20T02:29:50.637639Z","steps":["trace[1701410074] 'process raft request'  (duration: 138.039077ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:30:03.557618Z","caller":"traceutil/trace.go:171","msg":"trace[410863489] transaction","detail":"{read_only:false; response_revision:3448; number_of_response:1; }","duration":"109.346772ms","start":"2026-04-20T02:30:03.448238Z","end":"2026-04-20T02:30:03.557585Z","steps":["trace[410863489] 'process raft request'  (duration: 109.117966ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:30:03.785503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.10018ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.3\" ","response":"range_response_count:1 size:131"}
{"level":"info","ts":"2026-04-20T02:30:03.785624Z","caller":"traceutil/trace.go:171","msg":"trace[621123053] range","detail":"{range_begin:/registry/masterleases/199.204.45.3; range_end:; response_count:1; response_revision:3448; }","duration":"115.288714ms","start":"2026-04-20T02:30:03.670308Z","end":"2026-04-20T02:30:03.785597Z","steps":["trace[621123053] 'range keys from in-memory index tree'  (duration: 114.805703ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:30:39.911142Z","caller":"traceutil/trace.go:171","msg":"trace[1872670900] transaction","detail":"{read_only:false; response_revision:3666; number_of_response:1; }","duration":"138.601908ms","start":"2026-04-20T02:30:39.772518Z","end":"2026-04-20T02:30:39.91112Z","steps":["trace[1872670900] 'process raft request'  (duration: 138.428725ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:30:45.66917Z","caller":"traceutil/trace.go:171","msg":"trace[1987966361] transaction","detail":"{read_only:false; response_revision:3704; number_of_response:1; }","duration":"197.926978ms","start":"2026-04-20T02:30:45.471216Z","end":"2026-04-20T02:30:45.669143Z","steps":["trace[1987966361] 'process raft request'  (duration: 197.764734ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:30:46.068502Z","caller":"traceutil/trace.go:171","msg":"trace[1283371137] transaction","detail":"{read_only:false; response_revision:3705; number_of_response:1; }","duration":"137.871742ms","start":"2026-04-20T02:30:45.930594Z","end":"2026-04-20T02:30:46.068466Z","steps":["trace[1283371137] 'process raft request'  (duration: 137.702979ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:32:13.90042Z","caller":"traceutil/trace.go:171","msg":"trace[1361725210] transaction","detail":"{read_only:false; response_revision:4248; number_of_response:1; }","duration":"113.710539ms","start":"2026-04-20T02:32:13.78667Z","end":"2026-04-20T02:32:13.90038Z","steps":["trace[1361725210] 'process raft request'  (duration: 113.449504ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:34:10.757879Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2405}
{"level":"info","ts":"2026-04-20T02:34:10.830303Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2405,"took":"70.54635ms","hash":4286330444,"current-db-size-bytes":42078208,"current-db-size":"42 MB","current-db-size-in-use-bytes":20271104,"current-db-size-in-use":"20 MB"}
{"level":"info","ts":"2026-04-20T02:34:10.830392Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4286330444,"revision":2405,"compact-revision":-1}
{"level":"info","ts":"2026-04-20T02:36:06.621333Z","caller":"traceutil/trace.go:171","msg":"trace[1977922560] linearizableReadLoop","detail":"{readStateIndex:6718; appliedIndex:6717; }","duration":"142.283215ms","start":"2026-04-20T02:36:06.479004Z","end":"2026-04-20T02:36:06.621287Z","steps":["trace[1977922560] 'read index received'  (duration: 125.348577ms)","trace[1977922560] 'applied index is now lower than readState.Index'  (duration: 16.933578ms)"],"step_count":2}
{"level":"info","ts":"2026-04-20T02:36:06.621369Z","caller":"traceutil/trace.go:171","msg":"trace[1857522622] transaction","detail":"{read_only:false; number_of_response:1; response_revision:6470; }","duration":"152.5756ms","start":"2026-04-20T02:36:06.468747Z","end":"2026-04-20T02:36:06.621323Z","steps":["trace[1857522622] 'process raft request'  (duration: 135.589171ms)","trace[1857522622] 'compare'  (duration: 16.853456ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-20T02:36:06.621638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.615643ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config\" ","response":"range_response_count:1 size:708"}
{"level":"info","ts":"2026-04-20T02:36:06.621697Z","caller":"traceutil/trace.go:171","msg":"trace[1492143898] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config; range_end:; response_count:1; response_revision:6470; }","duration":"142.715485ms","start":"2026-04-20T02:36:06.478968Z","end":"2026-04-20T02:36:06.621683Z","steps":["trace[1492143898] 'agreement among raft nodes before linearized reading'  (duration: 142.48021ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:36:06.65161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.742473ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.carvel.dev/secretimports/\" range_end:\"/registry/secretgen.carvel.dev/secretimports0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-20T02:36:06.651709Z","caller":"traceutil/trace.go:171","msg":"trace[727663276] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secretimports/; range_end:/registry/secretgen.carvel.dev/secretimports0; response_count:0; response_revision:6471; }","duration":"163.893357ms","start":"2026-04-20T02:36:06.487779Z","end":"2026-04-20T02:36:06.651672Z","steps":["trace[727663276] 'agreement among raft nodes before linearized reading'  (duration: 163.753934ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:36:06.652008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.967689ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:56 size:2210220"}
{"level":"info","ts":"2026-04-20T02:36:06.652074Z","caller":"traceutil/trace.go:171","msg":"trace[677917809] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:56; response_revision:6471; }","duration":"131.093552ms","start":"2026-04-20T02:36:06.520964Z","end":"2026-04-20T02:36:06.652057Z","steps":["trace[677917809] 'agreement among raft nodes before linearized reading'  (duration: 130.271253ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:36:06.652159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.108556ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-zcdtl-tls\" ","response":"range_response_count:1 size:1814"}
{"level":"info","ts":"2026-04-20T02:36:06.652253Z","caller":"traceutil/trace.go:171","msg":"trace[523391677] range","detail":"{range_begin:/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-zcdtl-tls; range_end:; response_count:1; response_revision:6471; }","duration":"167.173088ms","start":"2026-04-20T02:36:06.485024Z","end":"2026-04-20T02:36:06.652197Z","steps":["trace[523391677] 'agreement among raft nodes before linearized reading'  (duration: 167.017945ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:36:06.652744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.61934ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-0fef368f-5fcb-4666-961c-020adfaa18f0\" ","response":"range_response_count:1 size:3772"}
{"level":"info","ts":"2026-04-20T02:36:06.652787Z","caller":"traceutil/trace.go:171","msg":"trace[514216329] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-0fef368f-5fcb-4666-961c-020adfaa18f0; range_end:; response_count:1; response_revision:6471; }","duration":"112.684881ms","start":"2026-04-20T02:36:06.540091Z","end":"2026-04-20T02:36:06.652776Z","steps":["trace[514216329] 'agreement among raft nodes before linearized reading'  (duration: 112.564639ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:36:13.023519Z","caller":"traceutil/trace.go:171","msg":"trace[1587660709] linearizableReadLoop","detail":"{readStateIndex:6816; appliedIndex:6815; }","duration":"121.579744ms","start":"2026-04-20T02:36:12.901907Z","end":"2026-04-20T02:36:13.023487Z","steps":["trace[1587660709] 'read index received'  (duration: 121.256587ms)","trace[1587660709] 'applied index is now lower than readState.Index'  (duration: 321.927µs)"],"step_count":2}
{"level":"info","ts":"2026-04-20T02:36:13.023851Z","caller":"traceutil/trace.go:171","msg":"trace[311535663] transaction","detail":"{read_only:false; response_revision:6567; number_of_response:1; }","duration":"148.532712ms","start":"2026-04-20T02:36:12.875305Z","end":"2026-04-20T02:36:13.023838Z","steps":["trace[311535663] 'process raft request'  (duration: 148.0002ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:36:13.02421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.050088ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-lh75d\" ","response":"range_response_count:1 size:6443"}
{"level":"warn","ts":"2026-04-20T02:36:13.024466Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.532155ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-04-20T02:36:13.024525Z","caller":"traceutil/trace.go:171","msg":"trace[1465059699] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:6567; }","duration":"122.657108ms","start":"2026-04-20T02:36:12.901854Z","end":"2026-04-20T02:36:13.024511Z","steps":["trace[1465059699] 'agreement among raft nodes before linearized reading'  (duration: 122.523764ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:36:13.024915Z","caller":"traceutil/trace.go:171","msg":"trace[357854686] range","detail":"{range_begin:/registry/pods/openstack/keepalived-lh75d; range_end:; response_count:1; response_revision:6567; }","duration":"101.787995ms","start":"2026-04-20T02:36:12.923087Z","end":"2026-04-20T02:36:13.024875Z","steps":["trace[357854686] 'agreement among raft nodes before linearized reading'  (duration: 100.979677ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:38:32.356182Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002127.wal"}
{"level":"info","ts":"2026-04-20T02:38:47.49393Z","caller":"traceutil/trace.go:171","msg":"trace[775061264] transaction","detail":"{read_only:false; response_revision:8828; number_of_response:1; }","duration":"112.588709ms","start":"2026-04-20T02:38:47.38129Z","end":"2026-04-20T02:38:47.493878Z","steps":["trace[775061264] 'process raft request'  (duration: 112.395475ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:38:48.726988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.122833ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12214"}
{"level":"info","ts":"2026-04-20T02:38:48.727205Z","caller":"traceutil/trace.go:171","msg":"trace[1204159175] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8856; }","duration":"102.412129ms","start":"2026-04-20T02:38:48.62476Z","end":"2026-04-20T02:38:48.727172Z","steps":["trace[1204159175] 'range keys from in-memory index tree'  (duration: 101.903268ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:38:53.113609Z","caller":"traceutil/trace.go:171","msg":"trace[2097366291] linearizableReadLoop","detail":"{readStateIndex:9194; appliedIndex:9192; }","duration":"144.363439ms","start":"2026-04-20T02:38:52.969197Z","end":"2026-04-20T02:38:53.11356Z","steps":["trace[2097366291] 'read index received'  (duration: 94.731173ms)","trace[2097366291] 'applied index is now lower than readState.Index'  (duration: 49.630666ms)"],"step_count":2}
{"level":"info","ts":"2026-04-20T02:38:53.113633Z","caller":"traceutil/trace.go:171","msg":"trace[1811938472] transaction","detail":"{read_only:false; response_revision:8891; number_of_response:1; }","duration":"176.090566ms","start":"2026-04-20T02:38:52.937494Z","end":"2026-04-20T02:38:53.113584Z","steps":["trace[1811938472] 'process raft request'  (duration: 126.506712ms)","trace[1811938472] 'compare'  (duration: 49.315888ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-20T02:38:53.113831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.261526ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/heat-domain-ks-user\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-20T02:38:53.113868Z","caller":"traceutil/trace.go:171","msg":"trace[1444579431] range","detail":"{range_begin:/registry/jobs/openstack/heat-domain-ks-user; range_end:; response_count:0; response_revision:8892; }","duration":"173.340997ms","start":"2026-04-20T02:38:52.940515Z","end":"2026-04-20T02:38:53.113856Z","steps":["trace[1444579431] 'agreement among raft nodes before linearized reading'  (duration: 173.248415ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:38:53.113864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.793484ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/heat-db-sync\" ","response":"range_response_count:1 size:4954"}
{"level":"warn","ts":"2026-04-20T02:38:53.113936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.922439ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/heat-ks-endpoints\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-20T02:38:53.113965Z","caller":"traceutil/trace.go:171","msg":"trace[1866035152] range","detail":"{range_begin:/registry/jobs/openstack/heat-db-sync; range_end:; response_count:1; response_revision:8892; }","duration":"172.938838ms","start":"2026-04-20T02:38:52.941005Z","end":"2026-04-20T02:38:53.113944Z","steps":["trace[1866035152] 'agreement among raft nodes before linearized reading'  (duration: 172.600541ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:38:53.113997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.677511ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/heat-bootstrap\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-20T02:38:53.114038Z","caller":"traceutil/trace.go:171","msg":"trace[1846541249] range","detail":"{range_begin:/registry/jobs/openstack/heat-bootstrap; range_end:; response_count:0; response_revision:8892; }","duration":"177.731942ms","start":"2026-04-20T02:38:52.936291Z","end":"2026-04-20T02:38:53.114023Z","steps":["trace[1846541249] 'agreement among raft nodes before linearized reading'  (duration: 177.67647ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:38:53.114042Z","caller":"traceutil/trace.go:171","msg":"trace[1043631914] transaction","detail":"{read_only:false; response_revision:8892; number_of_response:1; }","duration":"174.909871ms","start":"2026-04-20T02:38:52.939119Z","end":"2026-04-20T02:38:53.114029Z","steps":["trace[1043631914] 'process raft request'  (duration: 174.373869ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:38:53.113979Z","caller":"traceutil/trace.go:171","msg":"trace[1849736211] range","detail":"{range_begin:/registry/jobs/openstack/heat-ks-endpoints; range_end:; response_count:0; response_revision:8892; }","duration":"174.002371ms","start":"2026-04-20T02:38:52.939964Z","end":"2026-04-20T02:38:53.113967Z","steps":["trace[1849736211] 'agreement among raft nodes before linearized reading'  (duration: 173.93528ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:38:53.114214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.213059ms","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-20T02:38:53.114248Z","caller":"traceutil/trace.go:171","msg":"trace[930486918] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8892; }","duration":"153.288721ms","start":"2026-04-20T02:38:52.960949Z","end":"2026-04-20T02:38:53.114238Z","steps":["trace[930486918] 'agreement among raft nodes before linearized reading'  (duration: 153.189189ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:38:53.113929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.179373ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/heat-ks-user\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-20T02:38:53.114396Z","caller":"traceutil/trace.go:171","msg":"trace[231271568] range","detail":"{range_begin:/registry/jobs/openstack/heat-ks-user; range_end:; response_count:0; response_revision:8892; }","duration":"179.677474ms","start":"2026-04-20T02:38:52.934699Z","end":"2026-04-20T02:38:53.114376Z","steps":["trace[231271568] 'agreement among raft nodes before linearized reading'  (duration: 179.093922ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:39:10.780556Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":4952}
{"level":"info","ts":"2026-04-20T02:39:10.866725Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":4952,"took":"83.035ms","hash":3581997225,"current-db-size-bytes":50098176,"current-db-size":"50 MB","current-db-size-in-use-bytes":42094592,"current-db-size-in-use":"42 MB"}
{"level":"info","ts":"2026-04-20T02:39:10.866811Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3581997225,"revision":4952,"compact-revision":2405}
{"level":"info","ts":"2026-04-20T02:39:24.291133Z","caller":"traceutil/trace.go:171","msg":"trace[1547655485] transaction","detail":"{read_only:false; response_revision:9287; number_of_response:1; }","duration":"115.239309ms","start":"2026-04-20T02:39:24.175867Z","end":"2026-04-20T02:39:24.291107Z","steps":["trace[1547655485] 'process raft request'  (duration: 115.010844ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:39:53.6309Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"597401b06ce1cf3d","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-04-20T02:39:53.667253Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-04-20T02:39:53.667397Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-04-20T02:44:08.281923Z","caller":"traceutil/trace.go:171","msg":"trace[1439891509] transaction","detail":"{read_only:false; response_revision:12119; number_of_response:1; }","duration":"208.554289ms","start":"2026-04-20T02:44:08.073329Z","end":"2026-04-20T02:44:08.281883Z","steps":["trace[1439891509] 'process raft request'  (duration: 208.291334ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:44:08.281946Z","caller":"traceutil/trace.go:171","msg":"trace[118664522] linearizableReadLoop","detail":"{readStateIndex:12508; appliedIndex:12507; }","duration":"155.877153ms","start":"2026-04-20T02:44:08.125983Z","end":"2026-04-20T02:44:08.281861Z","steps":["trace[118664522] 'read index received'  (duration: 155.640768ms)","trace[118664522] 'applied index is now lower than readState.Index'  (duration: 234.695µs)"],"step_count":2}
{"level":"warn","ts":"2026-04-20T02:44:08.282173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.123568ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-20T02:44:08.282329Z","caller":"traceutil/trace.go:171","msg":"trace[1494087885] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:12119; }","duration":"156.368193ms","start":"2026-04-20T02:44:08.125932Z","end":"2026-04-20T02:44:08.2823Z","steps":["trace[1494087885] 'agreement among raft nodes before linearized reading'  (duration: 156.038756ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:44:08.481728Z","caller":"traceutil/trace.go:171","msg":"trace[1330949798] transaction","detail":"{read_only:false; response_revision:12120; number_of_response:1; }","duration":"169.635888ms","start":"2026-04-20T02:44:08.312058Z","end":"2026-04-20T02:44:08.481694Z","steps":["trace[1330949798] 'process raft request'  (duration: 74.269478ms)","trace[1330949798] 'compare'  (duration: 95.204376ms)"],"step_count":2}
{"level":"info","ts":"2026-04-20T02:44:08.491739Z","caller":"traceutil/trace.go:171","msg":"trace[1095398459] transaction","detail":"{read_only:false; response_revision:12121; number_of_response:1; }","duration":"130.201743ms","start":"2026-04-20T02:44:08.36151Z","end":"2026-04-20T02:44:08.491711Z","steps":["trace[1095398459] 'process raft request'  (duration: 130.04722ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:44:10.792909Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":9077}
{"level":"info","ts":"2026-04-20T02:44:10.942704Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":9077,"took":"145.622864ms","hash":2982215322,"current-db-size-bytes":59936768,"current-db-size":"60 MB","current-db-size-in-use-bytes":36470784,"current-db-size-in-use":"36 MB"}
{"level":"info","ts":"2026-04-20T02:44:10.942792Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2982215322,"revision":9077,"compact-revision":4952}
{"level":"info","ts":"2026-04-20T02:44:13.291792Z","caller":"traceutil/trace.go:171","msg":"trace[92141322] transaction","detail":"{read_only:false; response_revision:12415; number_of_response:1; }","duration":"237.176883ms","start":"2026-04-20T02:44:13.054583Z","end":"2026-04-20T02:44:13.29176Z","steps":["trace[92141322] 'process raft request'  (duration: 236.857726ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:44:13.292184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.763601ms","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-20T02:44:13.292254Z","caller":"traceutil/trace.go:171","msg":"trace[148226008] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:12415; }","duration":"212.889793ms","start":"2026-04-20T02:44:13.079346Z","end":"2026-04-20T02:44:13.292235Z","steps":["trace[148226008] 'agreement among raft nodes before linearized reading'  (duration: 212.617847ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:44:13.291711Z","caller":"traceutil/trace.go:171","msg":"trace[160081973] linearizableReadLoop","detail":"{readStateIndex:12812; appliedIndex:12811; }","duration":"212.27876ms","start":"2026-04-20T02:44:13.079404Z","end":"2026-04-20T02:44:13.291683Z","steps":["trace[160081973] 'read index received'  (duration: 212.109797ms)","trace[160081973] 'applied index is now lower than readState.Index'  (duration: 167.823µs)"],"step_count":2}
{"level":"warn","ts":"2026-04-20T02:44:13.292741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.132416ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-lh75d\" ","response":"range_response_count:1 size:6443"}
{"level":"info","ts":"2026-04-20T02:44:13.292776Z","caller":"traceutil/trace.go:171","msg":"trace[349071718] range","detail":"{range_begin:/registry/pods/openstack/keepalived-lh75d; range_end:; response_count:1; response_revision:12415; }","duration":"190.204158ms","start":"2026-04-20T02:44:13.102561Z","end":"2026-04-20T02:44:13.292765Z","steps":["trace[349071718] 'agreement among raft nodes before linearized reading'  (duration: 190.130647ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:44:13.292984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.509541ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-20T02:44:13.293014Z","caller":"traceutil/trace.go:171","msg":"trace[934611276] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:12415; }","duration":"166.563302ms","start":"2026-04-20T02:44:13.126442Z","end":"2026-04-20T02:44:13.293006Z","steps":["trace[934611276] 'agreement among raft nodes before linearized reading'  (duration: 166.516071ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:44:13.293495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.090303ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-04-20T02:44:13.293544Z","caller":"traceutil/trace.go:171","msg":"trace[2145339343] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:12415; }","duration":"167.200085ms","start":"2026-04-20T02:44:13.126329Z","end":"2026-04-20T02:44:13.293529Z","steps":["trace[2145339343] 'agreement among raft nodes before linearized reading'  (duration: 166.834247ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:44:13.458084Z","caller":"traceutil/trace.go:171","msg":"trace[845606049] transaction","detail":"{read_only:false; response_revision:12417; number_of_response:1; }","duration":"160.528083ms","start":"2026-04-20T02:44:13.297456Z","end":"2026-04-20T02:44:13.457984Z","steps":["trace[845606049] 'process raft request'  (duration: 160.158026ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:44:13.458435Z","caller":"traceutil/trace.go:171","msg":"trace[1127495655] transaction","detail":"{read_only:false; response_revision:12418; number_of_response:1; }","duration":"159.829588ms","start":"2026-04-20T02:44:13.298531Z","end":"2026-04-20T02:44:13.45836Z","steps":["trace[1127495655] 'process raft request'  (duration: 159.276457ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:44:13.458528Z","caller":"traceutil/trace.go:171","msg":"trace[1336784315] transaction","detail":"{read_only:false; response_revision:12419; number_of_response:1; }","duration":"137.611383ms","start":"2026-04-20T02:44:13.320899Z","end":"2026-04-20T02:44:13.458511Z","steps":["trace[1336784315] 'process raft request'  (duration: 137.333088ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:44:13.458507Z","caller":"traceutil/trace.go:171","msg":"trace[1703342172] linearizableReadLoop","detail":"{readStateIndex:12814; appliedIndex:12812; }","duration":"160.876931ms","start":"2026-04-20T02:44:13.297597Z","end":"2026-04-20T02:44:13.458474Z","steps":["trace[1703342172] 'read index received'  (duration: 63.801435ms)","trace[1703342172] 'applied index is now lower than readState.Index'  (duration: 97.074176ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-20T02:44:13.459671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.033376ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:91 size:860319"}
{"level":"info","ts":"2026-04-20T02:44:13.459721Z","caller":"traceutil/trace.go:171","msg":"trace[1163274533] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:91; response_revision:12419; }","duration":"162.135568ms","start":"2026-04-20T02:44:13.297573Z","end":"2026-04-20T02:44:13.459708Z","steps":["trace[1163274533] 'agreement among raft nodes before linearized reading'  (duration: 161.069474ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:44:17.072479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.682767ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-04-20T02:44:17.072656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.117145ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:668"}
{"level":"warn","ts":"2026-04-20T02:44:17.072563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.090044ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-20T02:44:17.072823Z","caller":"traceutil/trace.go:171","msg":"trace[482101268] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:12459; }","duration":"110.278628ms","start":"2026-04-20T02:44:16.962477Z","end":"2026-04-20T02:44:17.072756Z","steps":["trace[482101268] 'range keys from in-memory index tree'  (duration: 109.883609ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:44:17.072884Z","caller":"traceutil/trace.go:171","msg":"trace[1506650178] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:12459; }","duration":"110.517883ms","start":"2026-04-20T02:44:16.962345Z","end":"2026-04-20T02:44:17.072863Z","steps":["trace[1506650178] 'range keys from in-memory index tree'  (duration: 109.966512ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:44:17.07256Z","caller":"traceutil/trace.go:171","msg":"trace[717210413] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:0; response_revision:12459; }","duration":"110.83163ms","start":"2026-04-20T02:44:16.961705Z","end":"2026-04-20T02:44:17.072537Z","steps":["trace[717210413] 'range keys from in-memory index tree'  (duration: 110.586195ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:44:22.510375Z","caller":"traceutil/trace.go:171","msg":"trace[1156691709] linearizableReadLoop","detail":"{readStateIndex:12941; appliedIndex:12940; }","duration":"210.962881ms","start":"2026-04-20T02:44:22.299391Z","end":"2026-04-20T02:44:22.510354Z","steps":["trace[1156691709] 'read index received'  (duration: 210.745687ms)","trace[1156691709] 'applied index is now lower than readState.Index'  (duration: 216.274µs)"],"step_count":2}
{"level":"info","ts":"2026-04-20T02:44:22.510531Z","caller":"traceutil/trace.go:171","msg":"trace[1382682360] transaction","detail":"{read_only:false; response_revision:12538; number_of_response:1; }","duration":"225.909591ms","start":"2026-04-20T02:44:22.284584Z","end":"2026-04-20T02:44:22.510494Z","steps":["trace[1382682360] 'process raft request'  (duration: 225.616395ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:44:22.510901Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.023012ms","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-20T02:44:22.510986Z","caller":"traceutil/trace.go:171","msg":"trace[826131912] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:12538; }","duration":"152.145875ms","start":"2026-04-20T02:44:22.35882Z","end":"2026-04-20T02:44:22.510966Z","steps":["trace[826131912] 'agreement among raft nodes before linearized reading'  (duration: 151.89105ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:44:22.511037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.609676ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-4qg5r\" ","response":"range_response_count:1 size:9710"}
{"level":"info","ts":"2026-04-20T02:44:22.511287Z","caller":"traceutil/trace.go:171","msg":"trace[1196323467] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-4qg5r; range_end:; response_count:1; response_revision:12538; }","duration":"211.882492ms","start":"2026-04-20T02:44:22.299369Z","end":"2026-04-20T02:44:22.511252Z","steps":["trace[1196323467] 'agreement among raft nodes before linearized reading'  (duration: 211.423382ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:44:22.809249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.926308ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14933265287327397725 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/jobs/openstack/rook-ceph-detect-version\" mod_revision:12090 > success:<request_put:<key:\"/registry/jobs/openstack/rook-ceph-detect-version\" value_size:2994 >> failure:<request_range:<key:\"/registry/jobs/openstack/rook-ceph-detect-version\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-20T02:44:22.809547Z","caller":"traceutil/trace.go:171","msg":"trace[1650696780] linearizableReadLoop","detail":"{readStateIndex:12947; appliedIndex:12945; }","duration":"160.763428ms","start":"2026-04-20T02:44:22.648702Z","end":"2026-04-20T02:44:22.809466Z","steps":["trace[1650696780] 'read index received'  (duration: 52.505913ms)","trace[1650696780] 'applied index is now lower than readState.Index'  (duration: 108.256355ms)"],"step_count":2}
{"level":"info","ts":"2026-04-20T02:44:22.809767Z","caller":"traceutil/trace.go:171","msg":"trace[930049461] transaction","detail":"{read_only:false; response_revision:12543; number_of_response:1; }","duration":"208.11606ms","start":"2026-04-20T02:44:22.601621Z","end":"2026-04-20T02:44:22.809737Z","steps":["trace[930049461] 'process raft request'  (duration: 99.595661ms)","trace[930049461] 'compare'  (duration: 107.744433ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-20T02:44:22.809841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.111235ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:559"}
{"level":"info","ts":"2026-04-20T02:44:22.809957Z","caller":"traceutil/trace.go:171","msg":"trace[698126162] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:12544; }","duration":"161.270598ms","start":"2026-04-20T02:44:22.648656Z","end":"2026-04-20T02:44:22.809927Z","steps":["trace[698126162] 'agreement among raft nodes before linearized reading'  (duration: 160.985712ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:44:22.81018Z","caller":"traceutil/trace.go:171","msg":"trace[1554213605] transaction","detail":"{read_only:false; response_revision:12544; number_of_response:1; }","duration":"206.427864ms","start":"2026-04-20T02:44:22.603653Z","end":"2026-04-20T02:44:22.810081Z","steps":["trace[1554213605] 'process raft request'  (duration: 205.735439ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:44:22.950034Z","caller":"traceutil/trace.go:171","msg":"trace[1074768924] transaction","detail":"{read_only:false; response_revision:12546; number_of_response:1; }","duration":"131.475372ms","start":"2026-04-20T02:44:22.818519Z","end":"2026-04-20T02:44:22.949994Z","steps":["trace[1074768924] 'process raft request'  (duration: 104.279541ms)","trace[1074768924] 'compare'  (duration: 26.958096ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-20T02:44:22.950308Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.288787ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-user\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-20T02:44:22.950345Z","caller":"traceutil/trace.go:171","msg":"trace[1429657866] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-user; range_end:; response_count:0; response_revision:12547; }","duration":"109.363879ms","start":"2026-04-20T02:44:22.840969Z","end":"2026-04-20T02:44:22.950333Z","steps":["trace[1429657866] 'agreement among raft nodes before linearized reading'  (duration: 109.073143ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:44:22.950316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.101864ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-endpoints\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-04-20T02:44:22.950383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.8933ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-20T02:44:22.950461Z","caller":"traceutil/trace.go:171","msg":"trace[413480966] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-endpoints; range_end:; response_count:0; response_revision:12547; }","duration":"109.337069ms","start":"2026-04-20T02:44:22.841099Z","end":"2026-04-20T02:44:22.950436Z","steps":["trace[413480966] 'agreement among raft nodes before linearized reading'  (duration: 109.043672ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:44:22.950426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.039337ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-rxwmk\" ","response":"range_response_count:1 size:4631"}
{"level":"warn","ts":"2026-04-20T02:44:22.950585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.389489ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5448"}
{"level":"info","ts":"2026-04-20T02:44:22.950668Z","caller":"traceutil/trace.go:171","msg":"trace[949553828] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:12547; }","duration":"101.499232ms","start":"2026-04-20T02:44:22.849151Z","end":"2026-04-20T02:44:22.95065Z","steps":["trace[949553828] 'agreement among raft nodes before linearized reading'  (duration: 100.959899ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:44:22.950561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.982037ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/rook-ceph-detect-version\" ","response":"range_response_count:1 size:3066"}
{"level":"info","ts":"2026-04-20T02:44:22.950726Z","caller":"traceutil/trace.go:171","msg":"trace[173012894] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-rxwmk; range_end:; response_count:1; response_revision:12547; }","duration":"127.457676ms","start":"2026-04-20T02:44:22.823174Z","end":"2026-04-20T02:44:22.950632Z","steps":["trace[173012894] 'agreement among raft nodes before linearized reading'  (duration: 126.911534ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:44:22.950788Z","caller":"traceutil/trace.go:171","msg":"trace[378541888] range","detail":"{range_begin:/registry/jobs/openstack/rook-ceph-detect-version; range_end:; response_count:1; response_revision:12547; }","duration":"127.258152ms","start":"2026-04-20T02:44:22.823511Z","end":"2026-04-20T02:44:22.950769Z","steps":["trace[378541888] 'agreement among raft nodes before linearized reading'  (duration: 126.559367ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:44:22.950558Z","caller":"traceutil/trace.go:171","msg":"trace[1466633898] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:12547; }","duration":"110.109826ms","start":"2026-04-20T02:44:22.840401Z","end":"2026-04-20T02:44:22.950511Z","steps":["trace[1466633898] 'agreement among raft nodes before linearized reading'  (duration: 109.648585ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:44:25.16122Z","caller":"traceutil/trace.go:171","msg":"trace[2026293850] linearizableReadLoop","detail":"{readStateIndex:12979; appliedIndex:12978; }","duration":"205.323611ms","start":"2026-04-20T02:44:24.955876Z","end":"2026-04-20T02:44:25.161199Z","steps":["trace[2026293850] 'read index received'  (duration: 205.183208ms)","trace[2026293850] 'applied index is now lower than readState.Index'  (duration: 139.493µs)"],"step_count":2}
{"level":"warn","ts":"2026-04-20T02:44:25.161366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.470154ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-20T02:44:25.161342Z","caller":"traceutil/trace.go:171","msg":"trace[548694101] transaction","detail":"{read_only:false; response_revision:12574; number_of_response:1; }","duration":"212.713799ms","start":"2026-04-20T02:44:24.948599Z","end":"2026-04-20T02:44:25.161313Z","steps":["trace[548694101] 'process raft request'  (duration: 212.436873ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:44:25.161388Z","caller":"traceutil/trace.go:171","msg":"trace[115561643] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:12574; }","duration":"205.532326ms","start":"2026-04-20T02:44:24.955849Z","end":"2026-04-20T02:44:25.161382Z","steps":["trace[115561643] 'agreement among raft nodes before linearized reading'  (duration: 205.468405ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:44:25.161505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.678897ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-endpoints\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-04-20T02:44:25.161541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.593497ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-user\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-20T02:44:25.161566Z","caller":"traceutil/trace.go:171","msg":"trace[1792179674] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-endpoints; range_end:; response_count:0; response_revision:12574; }","duration":"204.782769ms","start":"2026-04-20T02:44:24.95677Z","end":"2026-04-20T02:44:25.161553Z","steps":["trace[1792179674] 'agreement among raft nodes before linearized reading'  (duration: 204.660156ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:44:25.161572Z","caller":"traceutil/trace.go:171","msg":"trace[1388353318] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-user; range_end:; response_count:0; response_revision:12574; }","duration":"205.643148ms","start":"2026-04-20T02:44:24.95592Z","end":"2026-04-20T02:44:25.161563Z","steps":["trace[1388353318] 'agreement among raft nodes before linearized reading'  (duration: 205.580107ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:44:25.161533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.587018ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5448"}
{"level":"info","ts":"2026-04-20T02:44:25.161641Z","caller":"traceutil/trace.go:171","msg":"trace[1295914416] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:12574; }","duration":"205.71309ms","start":"2026-04-20T02:44:24.955905Z","end":"2026-04-20T02:44:25.161618Z","steps":["trace[1295914416] 'agreement among raft nodes before linearized reading'  (duration: 205.458085ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:44:25.161507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.879526ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-20T02:44:25.161725Z","caller":"traceutil/trace.go:171","msg":"trace[140415668] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:12574; }","duration":"151.154692ms","start":"2026-04-20T02:44:25.010557Z","end":"2026-04-20T02:44:25.161711Z","steps":["trace[140415668] 'agreement among raft nodes before linearized reading'  (duration: 150.891767ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:44:36.117643Z","caller":"traceutil/trace.go:171","msg":"trace[1112169283] linearizableReadLoop","detail":"{readStateIndex:13067; appliedIndex:13066; }","duration":"102.291268ms","start":"2026-04-20T02:44:36.015321Z","end":"2026-04-20T02:44:36.117612Z","steps":["trace[1112169283] 'read index received'  (duration: 79.070281ms)","trace[1112169283] 'applied index is now lower than readState.Index'  (duration: 23.219827ms)"],"step_count":2}
{"level":"info","ts":"2026-04-20T02:44:36.117776Z","caller":"traceutil/trace.go:171","msg":"trace[606407208] transaction","detail":"{read_only:false; response_revision:12660; number_of_response:1; }","duration":"146.012472ms","start":"2026-04-20T02:44:35.971689Z","end":"2026-04-20T02:44:36.117701Z","steps":["trace[606407208] 'process raft request'  (duration: 122.745664ms)","trace[606407208] 'compare'  (duration: 23.048384ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-20T02:44:36.118363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.517363ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5448"}
{"level":"info","ts":"2026-04-20T02:44:36.118557Z","caller":"traceutil/trace.go:171","msg":"trace[1117427420] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:12660; }","duration":"103.300289ms","start":"2026-04-20T02:44:36.015234Z","end":"2026-04-20T02:44:36.118534Z","steps":["trace[1117427420] 'agreement among raft nodes before linearized reading'  (duration: 102.493232ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:44:36.332839Z","caller":"traceutil/trace.go:171","msg":"trace[394404130] transaction","detail":"{read_only:false; response_revision:12661; number_of_response:1; }","duration":"207.392555ms","start":"2026-04-20T02:44:36.125372Z","end":"2026-04-20T02:44:36.332765Z","steps":["trace[394404130] 'process raft request'  (duration: 148.943355ms)","trace[394404130] 'compare'  (duration: 56.675272ms)"],"step_count":2}
{"level":"info","ts":"2026-04-20T02:49:10.80225Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12365}
{"level":"info","ts":"2026-04-20T02:49:10.925665Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12365,"took":"120.074844ms","hash":3048985208,"current-db-size-bytes":59936768,"current-db-size":"60 MB","current-db-size-in-use-bytes":32718848,"current-db-size-in-use":"33 MB"}
{"level":"info","ts":"2026-04-20T02:49:10.925737Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3048985208,"revision":12365,"compact-revision":9077}
{"level":"info","ts":"2026-04-20T02:51:04.048095Z","caller":"traceutil/trace.go:171","msg":"trace[137410641] linearizableReadLoop","detail":"{readStateIndex:16110; appliedIndex:16108; }","duration":"238.578657ms","start":"2026-04-20T02:51:03.809492Z","end":"2026-04-20T02:51:04.048071Z","steps":["trace[137410641] 'read index received'  (duration: 45.650225ms)","trace[137410641] 'applied index is now lower than readState.Index'  (duration: 192.927372ms)"],"step_count":2}
{"level":"info","ts":"2026-04-20T02:51:04.048166Z","caller":"traceutil/trace.go:171","msg":"trace[1233691408] transaction","detail":"{read_only:false; response_revision:15606; number_of_response:1; }","duration":"284.056438ms","start":"2026-04-20T02:51:03.764068Z","end":"2026-04-20T02:51:04.048124Z","steps":["trace[1233691408] 'process raft request'  (duration: 283.815033ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:51:04.04847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.959596ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/libvirt-libvirt-default-w4xmv\" ","response":"range_response_count:1 size:20768"}
{"level":"info","ts":"2026-04-20T02:51:04.048536Z","caller":"traceutil/trace.go:171","msg":"trace[1104823384] range","detail":"{range_begin:/registry/pods/openstack/libvirt-libvirt-default-w4xmv; range_end:; response_count:1; response_revision:15606; }","duration":"239.077447ms","start":"2026-04-20T02:51:03.809441Z","end":"2026-04-20T02:51:04.048519Z","steps":["trace[1104823384] 'agreement among raft nodes before linearized reading'  (duration: 238.72602ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:51:04.4462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.044534ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14933265287327409859 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/masterleases/199.204.45.3\" mod_revision:15518 > success:<request_put:<key:\"/registry/masterleases/199.204.45.3\" value_size:66 lease:5709893250472634048 >> failure:<request_range:<key:\"/registry/masterleases/199.204.45.3\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-20T02:51:04.446297Z","caller":"traceutil/trace.go:171","msg":"trace[1669023102] linearizableReadLoop","detail":"{readStateIndex:16111; appliedIndex:16110; }","duration":"398.120254ms","start":"2026-04-20T02:51:04.048163Z","end":"2026-04-20T02:51:04.446284Z","steps":["trace[1669023102] 'read index received'  (duration: 116.936137ms)","trace[1669023102] 'applied index is now lower than readState.Index'  (duration: 281.183187ms)"],"step_count":2}
{"level":"info","ts":"2026-04-20T02:51:04.446352Z","caller":"traceutil/trace.go:171","msg":"trace[1316638025] transaction","detail":"{read_only:false; response_revision:15607; number_of_response:1; }","duration":"589.690647ms","start":"2026-04-20T02:51:03.856653Z","end":"2026-04-20T02:51:04.446344Z","steps":["trace[1316638025] 'process raft request'  (duration: 308.409278ms)","trace[1316638025] 'compare'  (duration: 280.918661ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-20T02:51:04.446391Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:51:03.856615Z","time spent":"589.758708ms","remote":"127.0.0.1:46746","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":117,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/masterleases/199.204.45.3\" mod_revision:15518 > success:<request_put:<key:\"/registry/masterleases/199.204.45.3\" value_size:66 lease:5709893250472634048 >> failure:<request_range:<key:\"/registry/masterleases/199.204.45.3\" > >"}
{"level":"warn","ts":"2026-04-20T02:51:04.446626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"573.410639ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephblockpools/\" range_end:\"/registry/ceph.rook.io/cephblockpools0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-04-20T02:51:04.446679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"525.328231ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"}
{"level":"info","ts":"2026-04-20T02:51:04.44675Z","caller":"traceutil/trace.go:171","msg":"trace[2002225770] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:15607; }","duration":"525.404333ms","start":"2026-04-20T02:51:03.921324Z","end":"2026-04-20T02:51:04.446729Z","steps":["trace[2002225770] 'agreement among raft nodes before linearized reading'  (duration: 525.167488ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:51:04.446756Z","caller":"traceutil/trace.go:171","msg":"trace[205248591] range","detail":"{range_begin:/registry/ceph.rook.io/cephblockpools/; range_end:/registry/ceph.rook.io/cephblockpools0; response_count:0; response_revision:15607; }","duration":"573.562501ms","start":"2026-04-20T02:51:03.87314Z","end":"2026-04-20T02:51:04.446703Z","steps":["trace[205248591] 'agreement among raft nodes before linearized reading'  (duration: 573.354347ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:51:04.446787Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:51:03.921304Z","time spent":"525.476485ms","remote":"127.0.0.1:46966","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-04-20T02:51:04.446877Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:51:03.87312Z","time spent":"573.682825ms","remote":"127.0.0.1:34746","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":28,"request content":"key:\"/registry/ceph.rook.io/cephblockpools/\" range_end:\"/registry/ceph.rook.io/cephblockpools0\" count_only:true "}
{"level":"info","ts":"2026-04-20T02:51:04.465468Z","caller":"traceutil/trace.go:171","msg":"trace[282552193] transaction","detail":"{read_only:false; response_revision:15610; number_of_response:1; }","duration":"319.151497ms","start":"2026-04-20T02:51:04.146288Z","end":"2026-04-20T02:51:04.465439Z","steps":["trace[282552193] 'process raft request'  (duration: 319.080546ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:51:04.46568Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:51:04.146255Z","time spent":"319.323481ms","remote":"127.0.0.1:46966","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:15596 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:477 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"info","ts":"2026-04-20T02:51:04.465777Z","caller":"traceutil/trace.go:171","msg":"trace[1639047983] transaction","detail":"{read_only:false; response_revision:15608; number_of_response:1; }","duration":"405.143585ms","start":"2026-04-20T02:51:04.060606Z","end":"2026-04-20T02:51:04.465749Z","steps":["trace[1639047983] 'process raft request'  (duration: 404.524232ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:51:04.465844Z","caller":"traceutil/trace.go:171","msg":"trace[275741415] transaction","detail":"{read_only:false; response_revision:15609; number_of_response:1; }","duration":"403.710023ms","start":"2026-04-20T02:51:04.062103Z","end":"2026-04-20T02:51:04.465813Z","steps":["trace[275741415] 'process raft request'  (duration: 403.200952ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:51:04.465922Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:51:04.060568Z","time spent":"405.276548ms","remote":"127.0.0.1:46872","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":20887,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/openstack/libvirt-libvirt-default-w4xmv\" mod_revision:15529 > success:<request_put:<key:\"/registry/pods/openstack/libvirt-libvirt-default-w4xmv\" value_size:20823 >> failure:<request_range:<key:\"/registry/pods/openstack/libvirt-libvirt-default-w4xmv\" > >"}
{"level":"warn","ts":"2026-04-20T02:51:04.466138Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:51:04.062072Z","time spent":"403.873997ms","remote":"127.0.0.1:46966","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:15595 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:464 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"info","ts":"2026-04-20T02:51:04.525054Z","caller":"traceutil/trace.go:171","msg":"trace[649708635] transaction","detail":"{read_only:false; response_revision:15611; number_of_response:1; }","duration":"215.571724ms","start":"2026-04-20T02:51:04.309448Z","end":"2026-04-20T02:51:04.52502Z","steps":["trace[649708635] 'process raft request'  (duration: 215.35551ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:51:04.525297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"393.101757ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-20T02:51:04.525341Z","caller":"traceutil/trace.go:171","msg":"trace[195100461] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:15612; }","duration":"393.168878ms","start":"2026-04-20T02:51:04.13216Z","end":"2026-04-20T02:51:04.525329Z","steps":["trace[195100461] 'agreement among raft nodes before linearized reading'  (duration: 393.051976ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:51:04.525376Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:51:04.132085Z","time spent":"393.281291ms","remote":"127.0.0.1:52166","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "}
{"level":"warn","ts":"2026-04-20T02:51:04.525457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"398.465831ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-04-20T02:51:04.525497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.122637ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-04-20T02:51:04.525574Z","caller":"traceutil/trace.go:171","msg":"trace[2021398955] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:15612; }","duration":"398.619614ms","start":"2026-04-20T02:51:04.126915Z","end":"2026-04-20T02:51:04.525535Z","steps":["trace[2021398955] 'agreement among raft nodes before linearized reading'  (duration: 398.461071ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:51:04.525585Z","caller":"traceutil/trace.go:171","msg":"trace[177072979] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:15612; }","duration":"224.316172ms","start":"2026-04-20T02:51:04.301245Z","end":"2026-04-20T02:51:04.525561Z","steps":["trace[177072979] 'agreement among raft nodes before linearized reading'  (duration: 224.046556ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:51:04.525615Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:51:04.126885Z","time spent":"398.721607ms","remote":"127.0.0.1:46728","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-04-20T02:51:04.525604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.06697ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-04-20T02:51:04.525694Z","caller":"traceutil/trace.go:171","msg":"trace[1455747448] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:15612; }","duration":"344.224373ms","start":"2026-04-20T02:51:04.18145Z","end":"2026-04-20T02:51:04.525675Z","steps":["trace[1455747448] 'agreement among raft nodes before linearized reading'  (duration: 343.972848ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:51:04.525748Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:51:04.181421Z","time spent":"344.317445ms","remote":"127.0.0.1:46966","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-04-20T02:51:04.525875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.327598ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-20T02:51:04.525925Z","caller":"traceutil/trace.go:171","msg":"trace[1825236261] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:15612; }","duration":"141.444231ms","start":"2026-04-20T02:51:04.38447Z","end":"2026-04-20T02:51:04.525915Z","steps":["trace[1825236261] 'agreement among raft nodes before linearized reading'  (duration: 141.36816ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:51:14.624593Z","caller":"traceutil/trace.go:171","msg":"trace[400883032] transaction","detail":"{read_only:false; response_revision:15748; number_of_response:1; }","duration":"116.146681ms","start":"2026-04-20T02:51:14.508424Z","end":"2026-04-20T02:51:14.62457Z","steps":["trace[400883032] 'process raft request'  (duration: 71.818363ms)","trace[400883032] 'compare'  (duration: 44.200705ms)"],"step_count":2}
{"level":"info","ts":"2026-04-20T02:52:05.044698Z","caller":"traceutil/trace.go:171","msg":"trace[816712125] transaction","detail":"{read_only:false; response_revision:16290; number_of_response:1; }","duration":"226.873607ms","start":"2026-04-20T02:52:04.817784Z","end":"2026-04-20T02:52:05.044658Z","steps":["trace[816712125] 'process raft request'  (duration: 226.61517ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:52:05.066581Z","caller":"traceutil/trace.go:171","msg":"trace[1131888948] linearizableReadLoop","detail":"{readStateIndex:16814; appliedIndex:16812; }","duration":"160.514778ms","start":"2026-04-20T02:52:04.906035Z","end":"2026-04-20T02:52:05.066549Z","steps":["trace[1131888948] 'read index received'  (duration: 138.409196ms)","trace[1131888948] 'applied index is now lower than readState.Index'  (duration: 22.103702ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-20T02:52:05.066888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.831036ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"}
{"level":"info","ts":"2026-04-20T02:52:05.066925Z","caller":"traceutil/trace.go:171","msg":"trace[1071396638] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:16291; }","duration":"160.938427ms","start":"2026-04-20T02:52:04.905977Z","end":"2026-04-20T02:52:05.066915Z","steps":["trace[1071396638] 'agreement among raft nodes before linearized reading'  (duration: 160.731723ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:52:05.066723Z","caller":"traceutil/trace.go:171","msg":"trace[192649085] transaction","detail":"{read_only:false; response_revision:16291; number_of_response:1; }","duration":"208.34582ms","start":"2026-04-20T02:52:04.858323Z","end":"2026-04-20T02:52:05.066669Z","steps":["trace[192649085] 'process raft request'  (duration: 208.025393ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:52:05.067336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.760194ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"}
{"level":"info","ts":"2026-04-20T02:52:05.06761Z","caller":"traceutil/trace.go:171","msg":"trace[2110503873] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:16291; }","duration":"160.261364ms","start":"2026-04-20T02:52:04.907329Z","end":"2026-04-20T02:52:05.06759Z","steps":["trace[2110503873] 'agreement among raft nodes before linearized reading'  (duration: 159.527938ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:52:05.22457Z","caller":"traceutil/trace.go:171","msg":"trace[223441847] transaction","detail":"{read_only:false; response_revision:16293; number_of_response:1; }","duration":"153.230044ms","start":"2026-04-20T02:52:05.071301Z","end":"2026-04-20T02:52:05.224531Z","steps":["trace[223441847] 'process raft request'  (duration: 139.170794ms)","trace[223441847] 'compare'  (duration: 13.731793ms)"],"step_count":2}
{"level":"info","ts":"2026-04-20T02:52:05.225289Z","caller":"traceutil/trace.go:171","msg":"trace[1185445914] transaction","detail":"{read_only:false; response_revision:16294; number_of_response:1; }","duration":"152.343454ms","start":"2026-04-20T02:52:05.07291Z","end":"2026-04-20T02:52:05.225253Z","steps":["trace[1185445914] 'process raft request'  (duration: 151.627249ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:52:54.258551Z","caller":"traceutil/trace.go:171","msg":"trace[1155634132] transaction","detail":"{read_only:false; response_revision:16727; number_of_response:1; }","duration":"136.487325ms","start":"2026-04-20T02:52:54.122008Z","end":"2026-04-20T02:52:54.258496Z","steps":["trace[1155634132] 'process raft request'  (duration: 136.24627ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:52:59.351326Z","caller":"traceutil/trace.go:171","msg":"trace[601449629] transaction","detail":"{read_only:false; response_revision:16749; number_of_response:1; }","duration":"100.131838ms","start":"2026-04-20T02:52:59.251166Z","end":"2026-04-20T02:52:59.351298Z","steps":["trace[601449629] 'process raft request'  (duration: 99.943094ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:52:59.607964Z","caller":"traceutil/trace.go:171","msg":"trace[2062937421] linearizableReadLoop","detail":"{readStateIndex:17287; appliedIndex:17286; }","duration":"111.226236ms","start":"2026-04-20T02:52:59.496718Z","end":"2026-04-20T02:52:59.607944Z","steps":["trace[2062937421] 'read index received'  (duration: 111.086093ms)","trace[2062937421] 'applied index is now lower than readState.Index'  (duration: 139.013µs)"],"step_count":2}
{"level":"info","ts":"2026-04-20T02:52:59.608197Z","caller":"traceutil/trace.go:171","msg":"trace[1513120167] transaction","detail":"{read_only:false; response_revision:16752; number_of_response:1; }","duration":"126.244406ms","start":"2026-04-20T02:52:59.481946Z","end":"2026-04-20T02:52:59.60819Z","steps":["trace[1513120167] 'process raft request'  (duration: 125.877079ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:52:59.608381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.663235ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"}
{"level":"info","ts":"2026-04-20T02:52:59.608405Z","caller":"traceutil/trace.go:171","msg":"trace[1053741370] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:16752; }","duration":"111.737147ms","start":"2026-04-20T02:52:59.496661Z","end":"2026-04-20T02:52:59.608398Z","steps":["trace[1053741370] 'agreement among raft nodes before linearized reading'  (duration: 111.644305ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:52:59.608499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.104122ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"}
{"level":"info","ts":"2026-04-20T02:52:59.608516Z","caller":"traceutil/trace.go:171","msg":"trace[592962816] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:16752; }","duration":"110.190533ms","start":"2026-04-20T02:52:59.498321Z","end":"2026-04-20T02:52:59.608512Z","steps":["trace[592962816] 'agreement among raft nodes before linearized reading'  (duration: 110.143962ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:52:59.938707Z","caller":"traceutil/trace.go:171","msg":"trace[323479327] linearizableReadLoop","detail":"{readStateIndex:17290; appliedIndex:17287; }","duration":"130.797454ms","start":"2026-04-20T02:52:59.807867Z","end":"2026-04-20T02:52:59.938665Z","steps":["trace[323479327] 'read index received'  (duration: 66.44082ms)","trace[323479327] 'applied index is now lower than readState.Index'  (duration: 64.355244ms)"],"step_count":2}
{"level":"info","ts":"2026-04-20T02:52:59.938774Z","caller":"traceutil/trace.go:171","msg":"trace[1254900315] transaction","detail":"{read_only:false; response_revision:16754; number_of_response:1; }","duration":"324.922201ms","start":"2026-04-20T02:52:59.61381Z","end":"2026-04-20T02:52:59.938732Z","steps":["trace[1254900315] 'process raft request'  (duration: 324.707676ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:52:59.938863Z","caller":"traceutil/trace.go:171","msg":"trace[1878034556] transaction","detail":"{read_only:false; response_revision:16753; number_of_response:1; }","duration":"326.477695ms","start":"2026-04-20T02:52:59.612348Z","end":"2026-04-20T02:52:59.938826Z","steps":["trace[1878034556] 'process raft request'  (duration: 261.804963ms)","trace[1878034556] 'compare'  (duration: 63.850605ms)"],"step_count":2}
{"level":"info","ts":"2026-04-20T02:52:59.938897Z","caller":"traceutil/trace.go:171","msg":"trace[780326889] transaction","detail":"{read_only:false; response_revision:16755; number_of_response:1; }","duration":"324.785288ms","start":"2026-04-20T02:52:59.614068Z","end":"2026-04-20T02:52:59.938853Z","steps":["trace[780326889] 'process raft request'  (duration: 324.547283ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:52:59.938977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.08613ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-ks-user\" ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-04-20T02:52:59.939023Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:52:59.612322Z","time spent":"326.615008ms","remote":"127.0.0.1:46966","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:16744 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-04-20T02:52:59.939019Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:52:59.613789Z","time spent":"325.107595ms","remote":"127.0.0.1:46966","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:16703 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"warn","ts":"2026-04-20T02:52:59.939033Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T02:52:59.614051Z","time spent":"324.917371ms","remote":"127.0.0.1:46966","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:16745 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-04-20T02:52:59.939055Z","caller":"traceutil/trace.go:171","msg":"trace[527656749] range","detail":"{range_begin:/registry/jobs/openstack/manila-ks-user; range_end:; response_count:0; response_revision:16755; }","duration":"131.220703ms","start":"2026-04-20T02:52:59.807817Z","end":"2026-04-20T02:52:59.939038Z","steps":["trace[527656749] 'agreement among raft nodes before linearized reading'  (duration: 131.021069ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:52:59.93913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.225007ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-ks-endpoints\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-04-20T02:52:59.939154Z","caller":"traceutil/trace.go:171","msg":"trace[742793347] range","detail":"{range_begin:/registry/jobs/openstack/manila-ks-endpoints; range_end:; response_count:0; response_revision:16755; }","duration":"126.294379ms","start":"2026-04-20T02:52:59.812853Z","end":"2026-04-20T02:52:59.939148Z","steps":["trace[742793347] 'agreement among raft nodes before linearized reading'  (duration: 126.250348ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:52:59.939279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.494017ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-rabbit-init\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-04-20T02:52:59.939327Z","caller":"traceutil/trace.go:171","msg":"trace[1454473851] range","detail":"{range_begin:/registry/jobs/openstack/manila-rabbit-init; range_end:; response_count:0; response_revision:16755; }","duration":"130.6494ms","start":"2026-04-20T02:52:59.808663Z","end":"2026-04-20T02:52:59.939313Z","steps":["trace[1454473851] 'agreement among raft nodes before linearized reading'  (duration: 130.423465ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:52:59.939362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.691314ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-db-sync\" ","response":"range_response_count:1 size:5007"}
{"level":"info","ts":"2026-04-20T02:52:59.939471Z","caller":"traceutil/trace.go:171","msg":"trace[1450324806] range","detail":"{range_begin:/registry/jobs/openstack/manila-db-sync; range_end:; response_count:1; response_revision:16755; }","duration":"124.854957ms","start":"2026-04-20T02:52:59.81459Z","end":"2026-04-20T02:52:59.939445Z","steps":["trace[1450324806] 'agreement among raft nodes before linearized reading'  (duration: 124.508869ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:53:00.413118Z","caller":"traceutil/trace.go:171","msg":"trace[1481788171] transaction","detail":"{read_only:false; response_revision:16756; number_of_response:1; }","duration":"121.207139ms","start":"2026-04-20T02:53:00.29187Z","end":"2026-04-20T02:53:00.413078Z","steps":["trace[1481788171] 'process raft request'  (duration: 120.680958ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T02:53:00.678627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.831079ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclients/\" range_end:\"/registry/ceph.rook.io/cephclients0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-04-20T02:53:00.67873Z","caller":"traceutil/trace.go:171","msg":"trace[1627513524] range","detail":"{range_begin:/registry/ceph.rook.io/cephclients/; range_end:/registry/ceph.rook.io/cephclients0; response_count:0; response_revision:16756; }","duration":"148.005362ms","start":"2026-04-20T02:53:00.5307Z","end":"2026-04-20T02:53:00.678706Z","steps":["trace[1627513524] 'count revisions from in-memory index tree'  (duration: 147.704026ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:53:00.833009Z","caller":"traceutil/trace.go:171","msg":"trace[2106081829] transaction","detail":"{read_only:false; response_revision:16757; number_of_response:1; }","duration":"106.71549ms","start":"2026-04-20T02:53:00.72626Z","end":"2026-04-20T02:53:00.832976Z","steps":["trace[2106081829] 'process raft request'  (duration: 106.467265ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:53:01.230232Z","caller":"traceutil/trace.go:171","msg":"trace[1709296715] linearizableReadLoop","detail":"{readStateIndex:17293; appliedIndex:17292; }","duration":"178.635326ms","start":"2026-04-20T02:53:01.051571Z","end":"2026-04-20T02:53:01.230206Z","steps":["trace[1709296715] 'read index received'  (duration: 178.382551ms)","trace[1709296715] 'applied index is now lower than readState.Index'  (duration: 250.895µs)"],"step_count":2}
{"level":"warn","ts":"2026-04-20T02:53:01.230435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.8308ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-04-20T02:53:01.23045Z","caller":"traceutil/trace.go:171","msg":"trace[1690930715] transaction","detail":"{read_only:false; response_revision:16758; number_of_response:1; }","duration":"262.415576ms","start":"2026-04-20T02:53:00.967979Z","end":"2026-04-20T02:53:01.230394Z","steps":["trace[1690930715] 'process raft request'  (duration: 262.018178ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:53:01.230494Z","caller":"traceutil/trace.go:171","msg":"trace[2090263759] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:16758; }","duration":"178.915012ms","start":"2026-04-20T02:53:01.05156Z","end":"2026-04-20T02:53:01.230475Z","steps":["trace[2090263759] 'agreement among raft nodes before linearized reading'  (duration: 178.776999ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:53:01.396281Z","caller":"traceutil/trace.go:171","msg":"trace[1090610820] linearizableReadLoop","detail":"{readStateIndex:17294; appliedIndex:17293; }","duration":"165.943075ms","start":"2026-04-20T02:53:01.230307Z","end":"2026-04-20T02:53:01.39625Z","steps":["trace[1090610820] 'read index received'  (duration: 82.540793ms)","trace[1090610820] 'applied index is now lower than readState.Index'  (duration: 83.401032ms)"],"step_count":2}
{"level":"info","ts":"2026-04-20T02:53:01.396371Z","caller":"traceutil/trace.go:171","msg":"trace[2047692301] transaction","detail":"{read_only:false; response_revision:16759; number_of_response:1; }","duration":"247.086238ms","start":"2026-04-20T02:53:01.14922Z","end":"2026-04-20T02:53:01.396306Z","steps":["trace[2047692301] 'process raft request'  (duration: 163.622505ms)","trace[2047692301] 'compare'  (duration: 83.061395ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-20T02:53:01.396675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.459759ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-4qg5r\" ","response":"range_response_count:1 size:9711"}
{"level":"info","ts":"2026-04-20T02:53:01.396733Z","caller":"traceutil/trace.go:171","msg":"trace[306376277] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-4qg5r; range_end:; response_count:1; response_revision:16759; }","duration":"205.676304ms","start":"2026-04-20T02:53:01.191042Z","end":"2026-04-20T02:53:01.396718Z","steps":["trace[306376277] 'agreement among raft nodes before linearized reading'  (duration: 205.331996ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:54:10.807812Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14822}
{"level":"info","ts":"2026-04-20T02:54:10.934322Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14822,"took":"121.296461ms","hash":2503066659,"current-db-size-bytes":59936768,"current-db-size":"60 MB","current-db-size-in-use-bytes":34705408,"current-db-size-in-use":"35 MB"}
{"level":"info","ts":"2026-04-20T02:54:10.934386Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2503066659,"revision":14822,"compact-revision":12365}
{"level":"info","ts":"2026-04-20T02:57:06.965838Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"597401b06ce1cf3d","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-04-20T02:57:06.979134Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002}
{"level":"info","ts":"2026-04-20T02:57:06.97927Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002}
{"level":"warn","ts":"2026-04-20T02:57:13.061688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.115144ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"}
{"level":"info","ts":"2026-04-20T02:57:13.062209Z","caller":"traceutil/trace.go:171","msg":"trace[151475925] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:19534; }","duration":"253.690196ms","start":"2026-04-20T02:57:12.808494Z","end":"2026-04-20T02:57:13.062184Z","steps":["trace[151475925] 'range keys from in-memory index tree'  (duration: 252.898189ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T02:59:10.814484Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17519}
{"level":"info","ts":"2026-04-20T02:59:10.934731Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17519,"took":"115.201199ms","hash":1381891030,"current-db-size-bytes":59936768,"current-db-size":"60 MB","current-db-size-in-use-bytes":46419968,"current-db-size-in-use":"46 MB"}
{"level":"info","ts":"2026-04-20T02:59:10.934789Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1381891030,"revision":17519,"compact-revision":14822}
{"level":"warn","ts":"2026-04-20T03:00:34.694296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.596033ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14933265287327426397 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/capi-system/controller-leader-election-capi\" mod_revision:21653 > success:<request_put:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" > >>","response":"size:18"}
{"level":"info","ts":"2026-04-20T03:00:34.694439Z","caller":"traceutil/trace.go:171","msg":"trace[2018656025] linearizableReadLoop","detail":"{readStateIndex:22340; appliedIndex:22338; }","duration":"256.453713ms","start":"2026-04-20T03:00:34.437965Z","end":"2026-04-20T03:00:34.694419Z","steps":["trace[2018656025] 'read index received'  (duration: 62.917582ms)","trace[2018656025] 'applied index is now lower than readState.Index'  (duration: 193.534351ms)"],"step_count":2}
{"level":"info","ts":"2026-04-20T03:00:34.69449Z","caller":"traceutil/trace.go:171","msg":"trace[839116706] transaction","detail":"{read_only:false; response_revision:21668; number_of_response:1; }","duration":"284.783137ms","start":"2026-04-20T03:00:34.409662Z","end":"2026-04-20T03:00:34.694445Z","steps":["trace[839116706] 'process raft request'  (duration: 155.333615ms)","trace[839116706] 'compare'  (duration: 127.382699ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-20T03:00:34.69479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.789189ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/\" range_end:\"/registry/cert-manager.io/certificates0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"warn","ts":"2026-04-20T03:00:34.694871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.52737ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"}
{"level":"info","ts":"2026-04-20T03:00:34.694912Z","caller":"traceutil/trace.go:171","msg":"trace[1281036886] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:21668; }","duration":"141.613342ms","start":"2026-04-20T03:00:34.553288Z","end":"2026-04-20T03:00:34.694901Z","steps":["trace[1281036886] 'agreement among raft nodes before linearized reading'  (duration: 141.442438ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T03:00:34.694914Z","caller":"traceutil/trace.go:171","msg":"trace[783716304] range","detail":"{range_begin:/registry/cert-manager.io/certificates/; range_end:/registry/cert-manager.io/certificates0; response_count:0; response_revision:21668; }","duration":"257.022314ms","start":"2026-04-20T03:00:34.43786Z","end":"2026-04-20T03:00:34.694883Z","steps":["trace[783716304] 'agreement among raft nodes before linearized reading'  (duration: 256.723058ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T03:00:42.82954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.740888ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"}
{"level":"info","ts":"2026-04-20T03:00:42.829663Z","caller":"traceutil/trace.go:171","msg":"trace[1590998169] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:21731; }","duration":"151.917311ms","start":"2026-04-20T03:00:42.67772Z","end":"2026-04-20T03:00:42.829637Z","steps":["trace[1590998169] 'range keys from in-memory index tree'  (duration: 151.538654ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T03:00:43.332677Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14933265287327426536,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-04-20T03:00:43.425532Z","caller":"traceutil/trace.go:171","msg":"trace[1345562537] transaction","detail":"{read_only:false; response_revision:21732; number_of_response:1; }","duration":"690.805033ms","start":"2026-04-20T03:00:42.734693Z","end":"2026-04-20T03:00:43.425498Z","steps":["trace[1345562537] 'process raft request'  (duration: 690.521927ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T03:00:43.425741Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T03:00:42.734668Z","time spent":"690.965646ms","remote":"127.0.0.1:46966","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/capi-system/controller-leader-election-capi\" mod_revision:21717 > success:<request_put:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" > >"}
{"level":"info","ts":"2026-04-20T03:00:43.758067Z","caller":"traceutil/trace.go:171","msg":"trace[1193883344] linearizableReadLoop","detail":"{readStateIndex:22409; appliedIndex:22404; }","duration":"925.928231ms","start":"2026-04-20T03:00:42.832107Z","end":"2026-04-20T03:00:43.758035Z","steps":["trace[1193883344] 'read index received'  (duration: 593.018786ms)","trace[1193883344] 'applied index is now lower than readState.Index'  (duration: 332.908175ms)"],"step_count":2}
{"level":"info","ts":"2026-04-20T03:00:43.758202Z","caller":"traceutil/trace.go:171","msg":"trace[675101373] transaction","detail":"{read_only:false; response_revision:21737; number_of_response:1; }","duration":"367.600284ms","start":"2026-04-20T03:00:43.39059Z","end":"2026-04-20T03:00:43.75819Z","steps":["trace[675101373] 'process raft request'  (duration: 367.39305ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T03:00:43.758203Z","caller":"traceutil/trace.go:171","msg":"trace[1161623679] transaction","detail":"{read_only:false; response_revision:21736; number_of_response:1; }","duration":"483.673562ms","start":"2026-04-20T03:00:43.274483Z","end":"2026-04-20T03:00:43.758156Z","steps":["trace[1161623679] 'process raft request'  (duration: 483.464388ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T03:00:43.758342Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T03:00:43.390562Z","time spent":"367.669656ms","remote":"127.0.0.1:46966","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:21725 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"warn","ts":"2026-04-20T03:00:43.758393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T03:00:43.274474Z","time spent":"483.812755ms","remote":"127.0.0.1:46966","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:21724 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:465 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"info","ts":"2026-04-20T03:00:43.75843Z","caller":"traceutil/trace.go:171","msg":"trace[314026330] transaction","detail":"{read_only:false; response_revision:21733; number_of_response:1; }","duration":"903.046062ms","start":"2026-04-20T03:00:42.855314Z","end":"2026-04-20T03:00:43.75836Z","steps":["trace[314026330] 'process raft request'  (duration: 902.346737ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T03:00:43.758501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"926.35872ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"}
{"level":"info","ts":"2026-04-20T03:00:43.758545Z","caller":"traceutil/trace.go:171","msg":"trace[28597826] transaction","detail":"{read_only:false; response_revision:21735; number_of_response:1; }","duration":"487.024733ms","start":"2026-04-20T03:00:43.271508Z","end":"2026-04-20T03:00:43.758533Z","steps":["trace[28597826] 'process raft request'  (duration: 486.40603ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T03:00:43.758586Z","caller":"traceutil/trace.go:171","msg":"trace[1953176736] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:21737; }","duration":"926.517803ms","start":"2026-04-20T03:00:42.832048Z","end":"2026-04-20T03:00:43.758566Z","steps":["trace[1953176736] 'agreement among raft nodes before linearized reading'  (duration: 926.213027ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T03:00:43.758606Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T03:00:43.27148Z","time spent":"487.096935ms","remote":"127.0.0.1:46966","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:21723 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"warn","ts":"2026-04-20T03:00:43.758625Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T03:00:42.832024Z","time spent":"926.595745ms","remote":"127.0.0.1:46966","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":463,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-04-20T03:00:43.758673Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T03:00:42.855285Z","time spent":"903.271177ms","remote":"127.0.0.1:46966","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":608,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" mod_revision:21720 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" value_size:507 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" > >"}
{"level":"info","ts":"2026-04-20T03:00:43.758816Z","caller":"traceutil/trace.go:171","msg":"trace[1717012469] transaction","detail":"{read_only:false; response_revision:21734; number_of_response:1; }","duration":"673.78018ms","start":"2026-04-20T03:00:43.085017Z","end":"2026-04-20T03:00:43.758797Z","steps":["trace[1717012469] 'process raft request'  (duration: 672.85018ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T03:00:43.758906Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T03:00:43.084989Z","time spent":"673.851511ms","remote":"127.0.0.1:46966","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:21722 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:477 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"info","ts":"2026-04-20T03:00:43.793399Z","caller":"traceutil/trace.go:171","msg":"trace[1328137829] transaction","detail":"{read_only:false; response_revision:21738; number_of_response:1; }","duration":"292.581544ms","start":"2026-04-20T03:00:43.500769Z","end":"2026-04-20T03:00:43.79335Z","steps":["trace[1328137829] 'process raft request'  (duration: 292.261037ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T03:00:43.793473Z","caller":"traceutil/trace.go:171","msg":"trace[786595561] transaction","detail":"{read_only:false; response_revision:21739; number_of_response:1; }","duration":"101.120318ms","start":"2026-04-20T03:00:43.692321Z","end":"2026-04-20T03:00:43.793442Z","steps":["trace[786595561] 'process raft request'  (duration: 100.921414ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T03:00:43.793762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"670.040619ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-04-20T03:00:43.793807Z","caller":"traceutil/trace.go:171","msg":"trace[926916593] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:21739; }","duration":"670.133992ms","start":"2026-04-20T03:00:43.123663Z","end":"2026-04-20T03:00:43.793797Z","steps":["trace[926916593] 'agreement among raft nodes before linearized reading'  (duration: 670.032648ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T03:00:43.793805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"375.611597ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/neutron-dhcp-agent-default-4gvdr.18a7f0fbf9d14e99\" ","response":"range_response_count:1 size:956"}
{"level":"info","ts":"2026-04-20T03:00:43.79384Z","caller":"traceutil/trace.go:171","msg":"trace[1950594951] range","detail":"{range_begin:/registry/events/openstack/neutron-dhcp-agent-default-4gvdr.18a7f0fbf9d14e99; range_end:; response_count:1; response_revision:21739; }","duration":"375.709539ms","start":"2026-04-20T03:00:43.418117Z","end":"2026-04-20T03:00:43.793827Z","steps":["trace[1950594951] 'agreement among raft nodes before linearized reading'  (duration: 375.507184ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T03:00:43.793837Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T03:00:43.123644Z","time spent":"670.182063ms","remote":"127.0.0.1:46728","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-04-20T03:00:43.793867Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T03:00:43.418096Z","time spent":"375.76342ms","remote":"127.0.0.1:46800","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":979,"request content":"key:\"/registry/events/openstack/neutron-dhcp-agent-default-4gvdr.18a7f0fbf9d14e99\" "}
{"level":"warn","ts":"2026-04-20T03:00:43.794068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.699581ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephblockpools/\" range_end:\"/registry/ceph.rook.io/cephblockpools0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-04-20T03:00:43.794092Z","caller":"traceutil/trace.go:171","msg":"trace[1488515961] range","detail":"{range_begin:/registry/ceph.rook.io/cephblockpools/; range_end:/registry/ceph.rook.io/cephblockpools0; response_count:0; response_revision:21739; }","duration":"101.784003ms","start":"2026-04-20T03:00:43.692301Z","end":"2026-04-20T03:00:43.794085Z","steps":["trace[1488515961] 'agreement among raft nodes before linearized reading'  (duration: 101.728311ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T03:00:43.794272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"752.353506ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-04-20T03:00:43.794325Z","caller":"traceutil/trace.go:171","msg":"trace[1508302871] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:21739; }","duration":"752.458688ms","start":"2026-04-20T03:00:43.041855Z","end":"2026-04-20T03:00:43.794314Z","steps":["trace[1508302871] 'agreement among raft nodes before linearized reading'  (duration: 752.169872ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T03:00:43.79436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"361.435954ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"}
{"level":"info","ts":"2026-04-20T03:00:43.794452Z","caller":"traceutil/trace.go:171","msg":"trace[1954727627] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:21739; }","duration":"361.571527ms","start":"2026-04-20T03:00:43.432855Z","end":"2026-04-20T03:00:43.794427Z","steps":["trace[1954727627] 'agreement among raft nodes before linearized reading'  (duration: 361.290241ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T03:00:43.794489Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T03:00:43.432837Z","time spent":"361.644618ms","remote":"127.0.0.1:46966","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":518,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-04-20T03:00:43.794499Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T03:00:43.041801Z","time spent":"752.684463ms","remote":"127.0.0.1:46966","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-04-20T03:00:43.794526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"942.914483ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"}
{"level":"info","ts":"2026-04-20T03:00:43.794562Z","caller":"traceutil/trace.go:171","msg":"trace[624838602] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:21739; }","duration":"942.992804ms","start":"2026-04-20T03:00:42.851557Z","end":"2026-04-20T03:00:43.79455Z","steps":["trace[624838602] 'agreement among raft nodes before linearized reading'  (duration: 942.892272ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T03:00:43.794582Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T03:00:42.851519Z","time spent":"943.058796ms","remote":"127.0.0.1:46872","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12238,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "}
{"level":"warn","ts":"2026-04-20T03:00:44.117539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.264767ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14933265287327426546 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:21718 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:18"}
{"level":"info","ts":"2026-04-20T03:00:44.117656Z","caller":"traceutil/trace.go:171","msg":"trace[1802949312] linearizableReadLoop","detail":"{readStateIndex:22413; appliedIndex:22412; }","duration":"324.24943ms","start":"2026-04-20T03:00:43.793387Z","end":"2026-04-20T03:00:44.117636Z","steps":["trace[1802949312] 'read index received'  (duration: 165.82837ms)","trace[1802949312] 'applied index is now lower than readState.Index'  (duration: 158.41912ms)"],"step_count":2}
{"level":"info","ts":"2026-04-20T03:00:44.117887Z","caller":"traceutil/trace.go:171","msg":"trace[580831142] transaction","detail":"{read_only:false; response_revision:21740; number_of_response:1; }","duration":"354.351762ms","start":"2026-04-20T03:00:43.763489Z","end":"2026-04-20T03:00:44.117841Z","steps":["trace[580831142] 'process raft request'  (duration: 195.677547ms)","trace[580831142] 'compare'  (duration: 157.826487ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-20T03:00:44.118084Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T03:00:43.763462Z","time spent":"354.521155ms","remote":"127.0.0.1:46966","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:21718 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-04-20T03:00:44.118234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"333.61022ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"}
{"level":"info","ts":"2026-04-20T03:00:44.118346Z","caller":"traceutil/trace.go:171","msg":"trace[1752034090] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:21740; }","duration":"333.755373ms","start":"2026-04-20T03:00:43.784552Z","end":"2026-04-20T03:00:44.118307Z","steps":["trace[1752034090] 'agreement among raft nodes before linearized reading'  (duration: 333.278903ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T03:00:44.118406Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T03:00:43.784535Z","time spent":"333.861015ms","remote":"127.0.0.1:46966","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":505,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-04-20T03:00:44.185616Z","caller":"traceutil/trace.go:171","msg":"trace[100452690] transaction","detail":"{read_only:false; response_revision:21741; number_of_response:1; }","duration":"385.672719ms","start":"2026-04-20T03:00:43.799905Z","end":"2026-04-20T03:00:44.185578Z","steps":["trace[100452690] 'process raft request'  (duration: 385.282051ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T03:00:44.185717Z","caller":"traceutil/trace.go:171","msg":"trace[891236296] transaction","detail":"{read_only:false; response_revision:21743; number_of_response:1; }","duration":"380.04311ms","start":"2026-04-20T03:00:43.80566Z","end":"2026-04-20T03:00:44.185703Z","steps":["trace[891236296] 'process raft request'  (duration: 379.852806ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T03:00:44.185795Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T03:00:43.805632Z","time spent":"380.113101ms","remote":"127.0.0.1:46800","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":939,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/events/openstack/neutron-dhcp-agent-default-4gvdr.18a7f0fbf9d14e99\" mod_revision:21235 > success:<request_put:<key:\"/registry/events/openstack/neutron-dhcp-agent-default-4gvdr.18a7f0fbf9d14e99\" value_size:845 lease:5709893250472650491 >> failure:<request_range:<key:\"/registry/events/openstack/neutron-dhcp-agent-default-4gvdr.18a7f0fbf9d14e99\" > >"}
{"level":"warn","ts":"2026-04-20T03:00:44.185795Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T03:00:43.799891Z","time spent":"385.810583ms","remote":"127.0.0.1:46966","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:21726 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-04-20T03:00:44.185846Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.250574ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:18409"}
{"level":"info","ts":"2026-04-20T03:00:44.185873Z","caller":"traceutil/trace.go:171","msg":"trace[1758091697] transaction","detail":"{read_only:false; response_revision:21742; number_of_response:1; }","duration":"384.208069ms","start":"2026-04-20T03:00:43.801626Z","end":"2026-04-20T03:00:44.185834Z","steps":["trace[1758091697] 'process raft request'  (duration: 383.81625ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T03:00:44.185923Z","caller":"traceutil/trace.go:171","msg":"trace[690496262] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:21743; }","duration":"388.349777ms","start":"2026-04-20T03:00:43.797553Z","end":"2026-04-20T03:00:44.185902Z","steps":["trace[690496262] 'agreement among raft nodes before linearized reading'  (duration: 388.055331ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T03:00:44.185969Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T03:00:43.797534Z","time spent":"388.423648ms","remote":"127.0.0.1:46860","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":18432,"request content":"key:\"/registry/minions/instance\" "}
{"level":"warn","ts":"2026-04-20T03:00:44.185993Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T03:00:43.801597Z","time spent":"384.334922ms","remote":"127.0.0.1:46966","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:21721 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-04-20T03:00:44.18606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"383.257929ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.3\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-04-20T03:00:44.186091Z","caller":"traceutil/trace.go:171","msg":"trace[848403251] range","detail":"{range_begin:/registry/masterleases/199.204.45.3; range_end:; response_count:1; response_revision:21743; }","duration":"383.31986ms","start":"2026-04-20T03:00:43.802763Z","end":"2026-04-20T03:00:44.186083Z","steps":["trace[848403251] 'agreement among raft nodes before linearized reading'  (duration: 383.205317ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T03:00:44.18611Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T03:00:43.802753Z","time spent":"383.352841ms","remote":"127.0.0.1:46746","response type":"/etcdserverpb.KV/Range","request count":0,"request size":37,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.204.45.3\" "}
{"level":"warn","ts":"2026-04-20T03:00:44.18625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.549062ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-04-20T03:00:44.18635Z","caller":"traceutil/trace.go:171","msg":"trace[1227261228] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:21743; }","duration":"388.678055ms","start":"2026-04-20T03:00:43.797645Z","end":"2026-04-20T03:00:44.186323Z","steps":["trace[1227261228] 'agreement among raft nodes before linearized reading'  (duration: 388.44942ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T03:00:44.186397Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T03:00:43.797635Z","time spent":"388.755606ms","remote":"127.0.0.1:46730","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-04-20T03:00:44.32445Z","caller":"traceutil/trace.go:171","msg":"trace[1697394527] linearizableReadLoop","detail":"{readStateIndex:22418; appliedIndex:22416; }","duration":"135.825419ms","start":"2026-04-20T03:00:44.188596Z","end":"2026-04-20T03:00:44.324421Z","steps":["trace[1697394527] 'read index received'  (duration: 90.746747ms)","trace[1697394527] 'applied index is now lower than readState.Index'  (duration: 45.077492ms)"],"step_count":2}
{"level":"info","ts":"2026-04-20T03:00:44.324748Z","caller":"traceutil/trace.go:171","msg":"trace[1586446587] transaction","detail":"{read_only:false; response_revision:21744; number_of_response:1; }","duration":"199.087828ms","start":"2026-04-20T03:00:44.125645Z","end":"2026-04-20T03:00:44.324733Z","steps":["trace[1586446587] 'process raft request'  (duration: 153.67954ms)","trace[1586446587] 'compare'  (duration: 44.792095ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-20T03:00:44.325249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.618886ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/sshkeys/\" range_end:\"/registry/secretgen.k14s.io/sshkeys0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-04-20T03:00:44.325338Z","caller":"traceutil/trace.go:171","msg":"trace[944520713] range","detail":"{range_begin:/registry/secretgen.k14s.io/sshkeys/; range_end:/registry/secretgen.k14s.io/sshkeys0; response_count:0; response_revision:21744; }","duration":"136.730799ms","start":"2026-04-20T03:00:44.188587Z","end":"2026-04-20T03:00:44.325317Z","steps":["trace[944520713] 'agreement among raft nodes before linearized reading'  (duration: 136.579766ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T03:00:44.325668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.651404ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/neutron-l3-agent-default-wmnwc.18a7f0face77824b\" ","response":"range_response_count:1 size:948"}
{"level":"info","ts":"2026-04-20T03:00:44.325712Z","caller":"traceutil/trace.go:171","msg":"trace[1604688547] range","detail":"{range_begin:/registry/events/openstack/neutron-l3-agent-default-wmnwc.18a7f0face77824b; range_end:; response_count:1; response_revision:21744; }","duration":"134.716565ms","start":"2026-04-20T03:00:44.190984Z","end":"2026-04-20T03:00:44.325701Z","steps":["trace[1604688547] 'agreement among raft nodes before linearized reading'  (duration: 134.552831ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T03:00:44.326237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.298402ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-04-20T03:00:44.326304Z","caller":"traceutil/trace.go:171","msg":"trace[909734839] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:21744; }","duration":"131.404704ms","start":"2026-04-20T03:00:44.194875Z","end":"2026-04-20T03:00:44.326279Z","steps":["trace[909734839] 'agreement among raft nodes before linearized reading'  (duration: 131.319992ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T03:00:44.667228Z","caller":"traceutil/trace.go:171","msg":"trace[419148292] linearizableReadLoop","detail":"{readStateIndex:22420; appliedIndex:22418; }","duration":"337.038432ms","start":"2026-04-20T03:00:44.330133Z","end":"2026-04-20T03:00:44.667172Z","steps":["trace[419148292] 'read index received'  (duration: 281.080288ms)","trace[419148292] 'applied index is now lower than readState.Index'  (duration: 55.957094ms)"],"step_count":2}
{"level":"info","ts":"2026-04-20T03:00:44.667252Z","caller":"traceutil/trace.go:171","msg":"trace[1626993263] transaction","detail":"{read_only:false; response_revision:21745; number_of_response:1; }","duration":"339.150508ms","start":"2026-04-20T03:00:44.327996Z","end":"2026-04-20T03:00:44.667147Z","steps":["trace[1626993263] 'process raft request'  (duration: 283.171653ms)","trace[1626993263] 'compare'  (duration: 55.560936ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-20T03:00:44.667448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.288377ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-04-20T03:00:44.667473Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T03:00:44.327967Z","time spent":"339.393082ms","remote":"127.0.0.1:46746","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":117,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/masterleases/199.204.45.3\" mod_revision:21666 > success:<request_put:<key:\"/registry/masterleases/199.204.45.3\" value_size:66 lease:5709893250472650746 >> failure:<request_range:<key:\"/registry/masterleases/199.204.45.3\" > >"}
{"level":"info","ts":"2026-04-20T03:00:44.667286Z","caller":"traceutil/trace.go:171","msg":"trace[795447701] transaction","detail":"{read_only:false; response_revision:21746; number_of_response:1; }","duration":"337.716926ms","start":"2026-04-20T03:00:44.329508Z","end":"2026-04-20T03:00:44.667225Z","steps":["trace[795447701] 'process raft request'  (duration: 337.534242ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T03:00:44.667497Z","caller":"traceutil/trace.go:171","msg":"trace[837373949] range","detail":"{range_begin:/registry/services/specs/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:21746; }","duration":"337.38303ms","start":"2026-04-20T03:00:44.330098Z","end":"2026-04-20T03:00:44.667481Z","steps":["trace[837373949] 'agreement among raft nodes before linearized reading'  (duration: 337.284918ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T03:00:44.667865Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T03:00:44.330089Z","time spent":"337.758768ms","remote":"127.0.0.1:46878","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":29,"request content":"key:\"/registry/services/specs/openstack/percona-xtradb-pitr\" "}
{"level":"warn","ts":"2026-04-20T03:00:44.668348Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T03:00:44.329498Z","time spent":"338.296098ms","remote":"127.0.0.1:46800","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":931,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/events/openstack/neutron-l3-agent-default-wmnwc.18a7f0face77824b\" mod_revision:21080 > success:<request_put:<key:\"/registry/events/openstack/neutron-l3-agent-default-wmnwc.18a7f0face77824b\" value_size:839 lease:5709893250472650491 >> failure:<request_range:<key:\"/registry/events/openstack/neutron-l3-agent-default-wmnwc.18a7f0face77824b\" > >"}
{"level":"warn","ts":"2026-04-20T03:00:44.667606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.407697ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/alertmanagerconfigs/\" range_end:\"/registry/monitoring.coreos.com/alertmanagerconfigs0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-04-20T03:00:44.67008Z","caller":"traceutil/trace.go:171","msg":"trace[138678394] range","detail":"{range_begin:/registry/monitoring.coreos.com/alertmanagerconfigs/; range_end:/registry/monitoring.coreos.com/alertmanagerconfigs0; response_count:0; response_revision:21746; }","duration":"337.959562ms","start":"2026-04-20T03:00:44.332099Z","end":"2026-04-20T03:00:44.670058Z","steps":["trace[138678394] 'agreement among raft nodes before linearized reading'  (duration: 335.377137ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T03:00:44.670121Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T03:00:44.332073Z","time spent":"338.034883ms","remote":"127.0.0.1:51034","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":29,"request content":"key:\"/registry/monitoring.coreos.com/alertmanagerconfigs/\" range_end:\"/registry/monitoring.coreos.com/alertmanagerconfigs0\" count_only:true "}
{"level":"info","ts":"2026-04-20T03:00:44.87419Z","caller":"traceutil/trace.go:171","msg":"trace[1037979602] linearizableReadLoop","detail":"{readStateIndex:22421; appliedIndex:22420; }","duration":"200.749894ms","start":"2026-04-20T03:00:44.673404Z","end":"2026-04-20T03:00:44.874154Z","steps":["trace[1037979602] 'read index received'  (duration: 170.914297ms)","trace[1037979602] 'applied index is now lower than readState.Index'  (duration: 29.833447ms)"],"step_count":2}
{"level":"info","ts":"2026-04-20T03:00:44.874423Z","caller":"traceutil/trace.go:171","msg":"trace[704908035] transaction","detail":"{read_only:false; response_revision:21747; number_of_response:1; }","duration":"201.407878ms","start":"2026-04-20T03:00:44.672963Z","end":"2026-04-20T03:00:44.874371Z","steps":["trace[704908035] 'process raft request'  (duration: 171.423589ms)","trace[704908035] 'compare'  (duration: 29.589471ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-20T03:00:44.874564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.120451ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:480"}
{"level":"info","ts":"2026-04-20T03:00:44.875134Z","caller":"traceutil/trace.go:171","msg":"trace[269692838] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:21747; }","duration":"201.729227ms","start":"2026-04-20T03:00:44.673383Z","end":"2026-04-20T03:00:44.875113Z","steps":["trace[269692838] 'agreement among raft nodes before linearized reading'  (duration: 200.97548ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T03:00:44.874629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.889667ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:18409"}
{"level":"info","ts":"2026-04-20T03:00:44.875273Z","caller":"traceutil/trace.go:171","msg":"trace[1240581437] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:21747; }","duration":"201.585873ms","start":"2026-04-20T03:00:44.67366Z","end":"2026-04-20T03:00:44.875246Z","steps":["trace[1240581437] 'agreement among raft nodes before linearized reading'  (duration: 200.755854ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T03:01:00.516604Z","caller":"traceutil/trace.go:171","msg":"trace[177556507] linearizableReadLoop","detail":"{readStateIndex:22545; appliedIndex:22544; }","duration":"242.470125ms","start":"2026-04-20T03:01:00.274097Z","end":"2026-04-20T03:01:00.516567Z","steps":["trace[177556507] 'read index received'  (duration: 160.131869ms)","trace[177556507] 'applied index is now lower than readState.Index'  (duration: 82.336816ms)"],"step_count":2}
{"level":"info","ts":"2026-04-20T03:01:00.516666Z","caller":"traceutil/trace.go:171","msg":"trace[1652274534] transaction","detail":"{read_only:false; response_revision:21868; number_of_response:1; }","duration":"264.404403ms","start":"2026-04-20T03:01:00.252192Z","end":"2026-04-20T03:01:00.516596Z","steps":["trace[1652274534] 'process raft request'  (duration: 182.055316ms)","trace[1652274534] 'compare'  (duration: 82.129992ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-20T03:01:00.516845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.70942ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-04-20T03:01:00.516935Z","caller":"traceutil/trace.go:171","msg":"trace[792423626] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:21868; }","duration":"242.823572ms","start":"2026-04-20T03:01:00.274092Z","end":"2026-04-20T03:01:00.516916Z","steps":["trace[792423626] 'agreement among raft nodes before linearized reading'  (duration: 242.562277ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T03:01:00.516942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.54904ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-04-20T03:01:00.51695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.963352ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"}
{"level":"info","ts":"2026-04-20T03:01:00.517017Z","caller":"traceutil/trace.go:171","msg":"trace[1008427423] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:21868; }","duration":"208.658012ms","start":"2026-04-20T03:01:00.308339Z","end":"2026-04-20T03:01:00.516997Z","steps":["trace[1008427423] 'agreement among raft nodes before linearized reading'  (duration: 208.511359ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T03:01:00.517023Z","caller":"traceutil/trace.go:171","msg":"trace[1776301877] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:21868; }","duration":"107.102225ms","start":"2026-04-20T03:01:00.409904Z","end":"2026-04-20T03:01:00.517006Z","steps":["trace[1776301877] 'agreement among raft nodes before linearized reading'  (duration: 106.883011ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T03:01:00.516954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.953431ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"}
{"level":"info","ts":"2026-04-20T03:01:00.517138Z","caller":"traceutil/trace.go:171","msg":"trace[1424720667] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:21868; }","duration":"240.169585ms","start":"2026-04-20T03:01:00.276942Z","end":"2026-04-20T03:01:00.517111Z","steps":["trace[1424720667] 'agreement among raft nodes before linearized reading'  (duration: 239.839759ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T03:01:00.868565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.464561ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14933265287327426845 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:21856 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:18"}
{"level":"info","ts":"2026-04-20T03:01:00.868729Z","caller":"traceutil/trace.go:171","msg":"trace[497698315] linearizableReadLoop","detail":"{readStateIndex:22548; appliedIndex:22546; }","duration":"291.112063ms","start":"2026-04-20T03:01:00.577601Z","end":"2026-04-20T03:01:00.868713Z","steps":["trace[497698315] 'read index received'  (duration: 103.432407ms)","trace[497698315] 'applied index is now lower than readState.Index'  (duration: 187.678496ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-20T03:01:00.868848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.249185ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"}
{"level":"info","ts":"2026-04-20T03:01:00.868816Z","caller":"traceutil/trace.go:171","msg":"trace[278474362] transaction","detail":"{read_only:false; response_revision:21870; number_of_response:1; }","duration":"345.962044ms","start":"2026-04-20T03:01:00.522791Z","end":"2026-04-20T03:01:00.868753Z","steps":["trace[278474362] 'process raft request'  (duration: 158.231447ms)","trace[278474362] 'compare'  (duration: 186.636493ms)"],"step_count":2}
{"level":"info","ts":"2026-04-20T03:01:00.868871Z","caller":"traceutil/trace.go:171","msg":"trace[1226861844] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:21871; }","duration":"291.314947ms","start":"2026-04-20T03:01:00.577547Z","end":"2026-04-20T03:01:00.868862Z","steps":["trace[1226861844] 'agreement among raft nodes before linearized reading'  (duration: 291.202144ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T03:01:00.868834Z","caller":"traceutil/trace.go:171","msg":"trace[1488788235] transaction","detail":"{read_only:false; response_revision:21871; number_of_response:1; }","duration":"345.453513ms","start":"2026-04-20T03:01:00.523322Z","end":"2026-04-20T03:01:00.868775Z","steps":["trace[1488788235] 'process raft request'  (duration: 345.338511ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T03:01:00.869028Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T03:01:00.522763Z","time spent":"346.146718ms","remote":"127.0.0.1:46966","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:21856 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-04-20T03:01:00.86907Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T03:01:00.523286Z","time spent":"345.658768ms","remote":"127.0.0.1:46966","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:21855 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-04-20T03:01:01.176124Z","caller":"traceutil/trace.go:171","msg":"trace[50832743] transaction","detail":"{read_only:false; response_revision:21872; number_of_response:1; }","duration":"143.513983ms","start":"2026-04-20T03:01:01.032581Z","end":"2026-04-20T03:01:01.176095Z","steps":["trace[50832743] 'process raft request'  (duration: 143.174886ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T03:01:01.449083Z","caller":"traceutil/trace.go:171","msg":"trace[114096018] transaction","detail":"{read_only:false; response_revision:21873; number_of_response:1; }","duration":"125.280154ms","start":"2026-04-20T03:01:01.323735Z","end":"2026-04-20T03:01:01.449016Z","steps":["trace[114096018] 'process raft request'  (duration: 111.624062ms)","trace[114096018] 'compare'  (duration: 13.298904ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-20T03:01:01.778934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.640339ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14933265287327426857 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/capi-system/controller-leader-election-capi\" mod_revision:21859 > success:<request_put:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" > >>","response":"size:18"}
{"level":"info","ts":"2026-04-20T03:01:01.779065Z","caller":"traceutil/trace.go:171","msg":"trace[603417159] linearizableReadLoop","detail":"{readStateIndex:22551; appliedIndex:22550; }","duration":"244.490108ms","start":"2026-04-20T03:01:01.534555Z","end":"2026-04-20T03:01:01.779046Z","steps":["trace[603417159] 'read index received'  (duration: 83.669075ms)","trace[603417159] 'applied index is now lower than readState.Index'  (duration: 160.819463ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-20T03:01:01.779304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.754184ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1866"}
{"level":"info","ts":"2026-04-20T03:01:01.779347Z","caller":"traceutil/trace.go:171","msg":"trace[1835626021] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:21874; }","duration":"244.837616ms","start":"2026-04-20T03:01:01.534494Z","end":"2026-04-20T03:01:01.779332Z","steps":["trace[1835626021] 'agreement among raft nodes before linearized reading'  (duration: 244.607151ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T03:01:01.779669Z","caller":"traceutil/trace.go:171","msg":"trace[1125693088] transaction","detail":"{read_only:false; response_revision:21874; number_of_response:1; }","duration":"273.908976ms","start":"2026-04-20T03:01:01.505741Z","end":"2026-04-20T03:01:01.77965Z","steps":["trace[1125693088] 'process raft request'  (duration: 112.426289ms)","trace[1125693088] 'compare'  (duration: 160.23043ms)"],"step_count":2}
{"level":"info","ts":"2026-04-20T03:01:01.966149Z","caller":"traceutil/trace.go:171","msg":"trace[449522896] linearizableReadLoop","detail":"{readStateIndex:22552; appliedIndex:22551; }","duration":"182.846172ms","start":"2026-04-20T03:01:01.783276Z","end":"2026-04-20T03:01:01.966122Z","steps":["trace[449522896] 'read index received'  (duration: 162.030218ms)","trace[449522896] 'applied index is now lower than readState.Index'  (duration: 20.814954ms)"],"step_count":2}
{"level":"info","ts":"2026-04-20T03:01:01.966249Z","caller":"traceutil/trace.go:171","msg":"trace[2072872195] transaction","detail":"{read_only:false; response_revision:21875; number_of_response:1; }","duration":"277.339798ms","start":"2026-04-20T03:01:01.688869Z","end":"2026-04-20T03:01:01.966209Z","steps":["trace[2072872195] 'process raft request'  (duration: 256.417822ms)","trace[2072872195] 'compare'  (duration: 20.571799ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-20T03:01:01.966476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.174619ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-6ee658f2-49e1-4a1b-92de-c7a0134371be\" ","response":"range_response_count:1 size:1323"}
{"level":"info","ts":"2026-04-20T03:01:01.966513Z","caller":"traceutil/trace.go:171","msg":"trace[842159787] range","detail":"{range_begin:/registry/persistentvolumes/pvc-6ee658f2-49e1-4a1b-92de-c7a0134371be; range_end:; response_count:1; response_revision:21875; }","duration":"183.273962ms","start":"2026-04-20T03:01:01.78323Z","end":"2026-04-20T03:01:01.966504Z","steps":["trace[842159787] 'agreement among raft nodes before linearized reading'  (duration: 183.014555ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T03:01:01.974835Z","caller":"traceutil/trace.go:171","msg":"trace[339522527] transaction","detail":"{read_only:false; response_revision:21876; number_of_response:1; }","duration":"128.171966ms","start":"2026-04-20T03:01:01.846632Z","end":"2026-04-20T03:01:01.974804Z","steps":["trace[339522527] 'process raft request'  (duration: 127.995401ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T03:01:01.97513Z","caller":"traceutil/trace.go:171","msg":"trace[1859642338] transaction","detail":"{read_only:false; response_revision:21877; number_of_response:1; }","duration":"124.482397ms","start":"2026-04-20T03:01:01.850623Z","end":"2026-04-20T03:01:01.975105Z","steps":["trace[1859642338] 'process raft request'  (duration: 124.13908ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T03:01:01.975255Z","caller":"traceutil/trace.go:171","msg":"trace[1733924320] transaction","detail":"{read_only:false; response_revision:21879; number_of_response:1; }","duration":"123.252081ms","start":"2026-04-20T03:01:01.851985Z","end":"2026-04-20T03:01:01.975237Z","steps":["trace[1733924320] 'process raft request'  (duration: 123.101528ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T03:01:01.975445Z","caller":"traceutil/trace.go:171","msg":"trace[398741966] transaction","detail":"{read_only:false; response_revision:21880; number_of_response:1; }","duration":"119.9578ms","start":"2026-04-20T03:01:01.855473Z","end":"2026-04-20T03:01:01.975431Z","steps":["trace[398741966] 'process raft request'  (duration: 119.675754ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T03:01:01.975567Z","caller":"traceutil/trace.go:171","msg":"trace[428619128] transaction","detail":"{read_only:false; response_revision:21878; number_of_response:1; }","duration":"124.460497ms","start":"2026-04-20T03:01:01.850742Z","end":"2026-04-20T03:01:01.975202Z","steps":["trace[428619128] 'process raft request'  (duration: 124.249643ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T03:01:36.100667Z","caller":"traceutil/trace.go:171","msg":"trace[1847077830] transaction","detail":"{read_only:false; response_revision:22136; number_of_response:1; }","duration":"128.115084ms","start":"2026-04-20T03:01:35.972525Z","end":"2026-04-20T03:01:36.10064Z","steps":["trace[1847077830] 'process raft request'  (duration: 127.854468ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T03:01:36.216333Z","caller":"traceutil/trace.go:171","msg":"trace[864321867] transaction","detail":"{read_only:false; response_revision:22138; number_of_response:1; }","duration":"105.235496ms","start":"2026-04-20T03:01:36.111053Z","end":"2026-04-20T03:01:36.216288Z","steps":["trace[864321867] 'process raft request'  (duration: 104.897609ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T03:02:02.341674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.097518ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14933265287327428001 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:22291 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:599 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >>","response":"size:18"}
{"level":"info","ts":"2026-04-20T03:02:02.341842Z","caller":"traceutil/trace.go:171","msg":"trace[1795563210] transaction","detail":"{read_only:false; response_revision:22365; number_of_response:1; }","duration":"131.511897ms","start":"2026-04-20T03:02:02.210315Z","end":"2026-04-20T03:02:02.341827Z","steps":["trace[1795563210] 'process raft request'  (duration: 131.461496ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T03:02:02.341904Z","caller":"traceutil/trace.go:171","msg":"trace[1328730773] linearizableReadLoop","detail":"{readStateIndex:23054; appliedIndex:23053; }","duration":"214.982428ms","start":"2026-04-20T03:02:02.126868Z","end":"2026-04-20T03:02:02.34185Z","steps":["trace[1328730773] 'read index received'  (duration: 83.506462ms)","trace[1328730773] 'applied index is now lower than readState.Index'  (duration: 131.472696ms)"],"step_count":2}
{"level":"info","ts":"2026-04-20T03:02:02.342038Z","caller":"traceutil/trace.go:171","msg":"trace[200518550] transaction","detail":"{read_only:false; response_revision:22364; number_of_response:1; }","duration":"234.606397ms","start":"2026-04-20T03:02:02.10742Z","end":"2026-04-20T03:02:02.342026Z","steps":["trace[200518550] 'process raft request'  (duration: 103.06085ms)","trace[200518550] 'compare'  (duration: 131.003556ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-20T03:02:02.342101Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.238634ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-04-20T03:02:02.342177Z","caller":"traceutil/trace.go:171","msg":"trace[594305259] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:22365; }","duration":"215.356156ms","start":"2026-04-20T03:02:02.126801Z","end":"2026-04-20T03:02:02.342157Z","steps":["trace[594305259] 'agreement among raft nodes before linearized reading'  (duration: 215.250634ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T03:02:02.663454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.105085ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14933265287327428004 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:22353 > success:<request_put:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" value_size:442 >> failure:<request_range:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" > >>","response":"size:18"}
{"level":"info","ts":"2026-04-20T03:02:02.663831Z","caller":"traceutil/trace.go:171","msg":"trace[1637507300] transaction","detail":"{read_only:false; response_revision:22367; number_of_response:1; }","duration":"348.079709ms","start":"2026-04-20T03:02:02.315699Z","end":"2026-04-20T03:02:02.663779Z","steps":["trace[1637507300] 'process raft request'  (duration: 173.177856ms)","trace[1637507300] 'compare'  (duration: 173.923062ms)"],"step_count":2}
{"level":"info","ts":"2026-04-20T03:02:02.664009Z","caller":"traceutil/trace.go:171","msg":"trace[1287108683] transaction","detail":"{read_only:false; response_revision:22368; number_of_response:1; }","duration":"347.914415ms","start":"2026-04-20T03:02:02.316066Z","end":"2026-04-20T03:02:02.66398Z","steps":["trace[1287108683] 'process raft request'  (duration: 347.627629ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T03:02:02.664036Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T03:02:02.315667Z","time spent":"348.260163ms","remote":"127.0.0.1:46966","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":498,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:22353 > success:<request_put:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" value_size:442 >> failure:<request_range:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" > >"}
{"level":"warn","ts":"2026-04-20T03:02:02.664111Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T03:02:02.316054Z","time spent":"348.007568ms","remote":"127.0.0.1:46966","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:22352 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-04-20T03:02:02.66423Z","caller":"traceutil/trace.go:171","msg":"trace[1697075428] transaction","detail":"{read_only:false; response_revision:22369; number_of_response:1; }","duration":"346.900753ms","start":"2026-04-20T03:02:02.317318Z","end":"2026-04-20T03:02:02.664219Z","steps":["trace[1697075428] 'process raft request'  (duration: 346.523046ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T03:02:02.664229Z","caller":"traceutil/trace.go:171","msg":"trace[1904641265] transaction","detail":"{read_only:false; response_revision:22370; number_of_response:1; }","duration":"344.735177ms","start":"2026-04-20T03:02:02.319479Z","end":"2026-04-20T03:02:02.664214Z","steps":["trace[1904641265] 'process raft request'  (duration: 344.644695ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T03:02:02.664279Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T03:02:02.317304Z","time spent":"346.945744ms","remote":"127.0.0.1:46966","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:22354 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-04-20T03:02:02.664368Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T03:02:02.319439Z","time spent":"344.82943ms","remote":"127.0.0.1:46966","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/capo-system/controller-leader-election-capo\" mod_revision:22355 > success:<request_put:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" > >"}
{"level":"info","ts":"2026-04-20T03:02:02.664412Z","caller":"traceutil/trace.go:171","msg":"trace[707000331] transaction","detail":"{read_only:false; response_revision:22371; number_of_response:1; }","duration":"343.835638ms","start":"2026-04-20T03:02:02.320549Z","end":"2026-04-20T03:02:02.664385Z","steps":["trace[707000331] 'process raft request'  (duration: 343.628264ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T03:02:02.664556Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T03:02:02.320537Z","time spent":"343.939541ms","remote":"127.0.0.1:46966","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:22356 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:465 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"info","ts":"2026-04-20T03:02:02.664655Z","caller":"traceutil/trace.go:171","msg":"trace[928320362] linearizableReadLoop","detail":"{readStateIndex:23062; appliedIndex:23055; }","duration":"322.636176ms","start":"2026-04-20T03:02:02.341979Z","end":"2026-04-20T03:02:02.664615Z","steps":["trace[928320362] 'read index received'  (duration: 4.377613ms)","trace[928320362] 'applied index is now lower than readState.Index'  (duration: 318.257523ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-20T03:02:02.664694Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.638565ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/flavors/\" range_end:\"/registry/openstack.k-orc.cloud/flavors0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-04-20T03:02:02.664667Z","caller":"traceutil/trace.go:171","msg":"trace[1411902253] transaction","detail":"{read_only:false; response_revision:22372; number_of_response:1; }","duration":"343.00178ms","start":"2026-04-20T03:02:02.321636Z","end":"2026-04-20T03:02:02.664638Z","steps":["trace[1411902253] 'process raft request'  (duration: 342.687144ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T03:02:02.664724Z","caller":"traceutil/trace.go:171","msg":"trace[763000874] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/flavors/; range_end:/registry/openstack.k-orc.cloud/flavors0; response_count:0; response_revision:22372; }","duration":"329.708047ms","start":"2026-04-20T03:02:02.335006Z","end":"2026-04-20T03:02:02.664714Z","steps":["trace[763000874] 'agreement among raft nodes before linearized reading'  (duration: 329.641995ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T03:02:02.664761Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T03:02:02.334982Z","time spent":"329.760567ms","remote":"127.0.0.1:41556","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":0,"response size":29,"request content":"key:\"/registry/openstack.k-orc.cloud/flavors/\" range_end:\"/registry/openstack.k-orc.cloud/flavors0\" count_only:true "}
{"level":"warn","ts":"2026-04-20T03:02:02.664835Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T03:02:02.321621Z","time spent":"343.109263ms","remote":"127.0.0.1:46966","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":608,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" mod_revision:22357 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" value_size:507 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" > >"}
{"level":"warn","ts":"2026-04-20T03:02:02.664844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.036955ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/machinesets/\" range_end:\"/registry/cluster.x-k8s.io/machinesets0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-04-20T03:02:02.664853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"532.283709ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"}
{"level":"info","ts":"2026-04-20T03:02:02.664891Z","caller":"traceutil/trace.go:171","msg":"trace[1840476288] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:22372; }","duration":"532.366881ms","start":"2026-04-20T03:02:02.132513Z","end":"2026-04-20T03:02:02.66488Z","steps":["trace[1840476288] 'agreement among raft nodes before linearized reading'  (duration: 532.198288ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T03:02:02.664884Z","caller":"traceutil/trace.go:171","msg":"trace[495024110] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machinesets/; range_end:/registry/cluster.x-k8s.io/machinesets0; response_count:0; response_revision:22372; }","duration":"138.122447ms","start":"2026-04-20T03:02:02.526749Z","end":"2026-04-20T03:02:02.664871Z","steps":["trace[495024110] 'agreement among raft nodes before linearized reading'  (duration: 138.025245ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T03:02:02.664923Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T03:02:02.132483Z","time spent":"532.431972ms","remote":"127.0.0.1:46872","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12238,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "}
{"level":"info","ts":"2026-04-20T03:02:09.385011Z","caller":"traceutil/trace.go:171","msg":"trace[424884618] linearizableReadLoop","detail":"{readStateIndex:23134; appliedIndex:23133; }","duration":"128.539324ms","start":"2026-04-20T03:02:09.256445Z","end":"2026-04-20T03:02:09.384984Z","steps":["trace[424884618] 'read index received'  (duration: 128.202347ms)","trace[424884618] 'applied index is now lower than readState.Index'  (duration: 335.687µs)"],"step_count":2}
{"level":"warn","ts":"2026-04-20T03:02:09.385307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.83612ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"}
{"level":"info","ts":"2026-04-20T03:02:09.385379Z","caller":"traceutil/trace.go:171","msg":"trace[442408766] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:22442; }","duration":"128.922451ms","start":"2026-04-20T03:02:09.256419Z","end":"2026-04-20T03:02:09.385342Z","steps":["trace[442408766] 'agreement among raft nodes before linearized reading'  (duration: 128.684696ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T03:02:09.385782Z","caller":"traceutil/trace.go:171","msg":"trace[1648937475] transaction","detail":"{read_only:false; response_revision:22442; number_of_response:1; }","duration":"133.502579ms","start":"2026-04-20T03:02:09.252259Z","end":"2026-04-20T03:02:09.385762Z","steps":["trace[1648937475] 'process raft request'  (duration: 132.473187ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T03:02:27.055976Z","caller":"traceutil/trace.go:171","msg":"trace[1960602191] transaction","detail":"{read_only:false; response_revision:22573; number_of_response:1; }","duration":"281.57884ms","start":"2026-04-20T03:02:26.774363Z","end":"2026-04-20T03:02:27.055942Z","steps":["trace[1960602191] 'process raft request'  (duration: 281.383286ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T03:02:27.350512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.603698ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14933265287327428465 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:22560 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >>","response":"size:18"}
{"level":"info","ts":"2026-04-20T03:02:27.352942Z","caller":"traceutil/trace.go:171","msg":"trace[1448897263] transaction","detail":"{read_only:false; response_revision:22575; number_of_response:1; }","duration":"577.459574ms","start":"2026-04-20T03:02:26.775408Z","end":"2026-04-20T03:02:27.352867Z","steps":["trace[1448897263] 'process raft request'  (duration: 575.233056ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T03:02:27.35321Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T03:02:26.775395Z","time spent":"577.678698ms","remote":"127.0.0.1:46966","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/capo-system/controller-leader-election-capo\" mod_revision:22561 > success:<request_put:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" > >"}
{"level":"info","ts":"2026-04-20T03:02:27.35091Z","caller":"traceutil/trace.go:171","msg":"trace[1838149540] transaction","detail":"{read_only:false; response_revision:22574; number_of_response:1; }","duration":"575.9019ms","start":"2026-04-20T03:02:26.774945Z","end":"2026-04-20T03:02:27.350847Z","steps":["trace[1838149540] 'process raft request'  (duration: 451.852413ms)","trace[1838149540] 'compare'  (duration: 122.990335ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-20T03:02:27.353478Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T03:02:26.774899Z","time spent":"578.512085ms","remote":"127.0.0.1:46966","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:22560 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"info","ts":"2026-04-20T03:02:27.353926Z","caller":"traceutil/trace.go:171","msg":"trace[1694619090] transaction","detail":"{read_only:false; response_revision:22576; number_of_response:1; }","duration":"573.013398ms","start":"2026-04-20T03:02:26.780869Z","end":"2026-04-20T03:02:27.353883Z","steps":["trace[1694619090] 'process raft request'  (duration: 572.63326ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T03:02:27.354157Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T03:02:26.780853Z","time spent":"573.114291ms","remote":"127.0.0.1:46966","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:22563 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:465 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"info","ts":"2026-04-20T03:02:27.354973Z","caller":"traceutil/trace.go:171","msg":"trace[1632739027] transaction","detail":"{read_only:false; response_revision:22578; number_of_response:1; }","duration":"573.444289ms","start":"2026-04-20T03:02:26.781467Z","end":"2026-04-20T03:02:27.354911Z","steps":["trace[1632739027] 'process raft request'  (duration: 573.019799ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T03:02:27.355158Z","caller":"traceutil/trace.go:171","msg":"trace[192876527] linearizableReadLoop","detail":"{readStateIndex:23273; appliedIndex:23267; }","duration":"537.254546ms","start":"2026-04-20T03:02:26.817809Z","end":"2026-04-20T03:02:27.355063Z","steps":["trace[192876527] 'read index received'  (duration: 238.006319ms)","trace[192876527] 'applied index is now lower than readState.Index'  (duration: 299.110884ms)"],"step_count":2}
{"level":"info","ts":"2026-04-20T03:02:27.35531Z","caller":"traceutil/trace.go:171","msg":"trace[264172111] transaction","detail":"{read_only:false; response_revision:22577; number_of_response:1; }","duration":"573.97068ms","start":"2026-04-20T03:02:26.781266Z","end":"2026-04-20T03:02:27.355237Z","steps":["trace[264172111] 'process raft request'  (duration: 572.403226ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T03:02:27.355351Z","caller":"traceutil/trace.go:171","msg":"trace[2140841163] transaction","detail":"{read_only:false; response_revision:22579; number_of_response:1; }","duration":"238.241915ms","start":"2026-04-20T03:02:27.117039Z","end":"2026-04-20T03:02:27.355281Z","steps":["trace[2140841163] 'process raft request'  (duration: 237.6128ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T03:02:27.355587Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T03:02:26.781459Z","time spent":"574.064522ms","remote":"127.0.0.1:46966","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":608,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" mod_revision:22562 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" value_size:507 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" > >"}
{"level":"warn","ts":"2026-04-20T03:02:27.355697Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T03:02:26.781256Z","time spent":"574.162313ms","remote":"127.0.0.1:46966","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:22564 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"warn","ts":"2026-04-20T03:02:27.356012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"445.582449ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/routers/\" range_end:\"/registry/openstack.k-orc.cloud/routers0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-04-20T03:02:27.356131Z","caller":"traceutil/trace.go:171","msg":"trace[537775046] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/routers/; range_end:/registry/openstack.k-orc.cloud/routers0; response_count:0; response_revision:22579; }","duration":"445.677622ms","start":"2026-04-20T03:02:26.910378Z","end":"2026-04-20T03:02:27.356055Z","steps":["trace[537775046] 'agreement among raft nodes before linearized reading'  (duration: 445.372975ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T03:02:27.356184Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T03:02:26.910356Z","time spent":"445.814764ms","remote":"127.0.0.1:41486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":0,"response size":29,"request content":"key:\"/registry/openstack.k-orc.cloud/routers/\" range_end:\"/registry/openstack.k-orc.cloud/routers0\" count_only:true "}
{"level":"warn","ts":"2026-04-20T03:02:27.356266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"538.42792ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"}
{"level":"warn","ts":"2026-04-20T03:02:27.356361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"394.283925ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-04-20T03:02:27.356399Z","caller":"traceutil/trace.go:171","msg":"trace[1889775121] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:22579; }","duration":"538.605504ms","start":"2026-04-20T03:02:26.817764Z","end":"2026-04-20T03:02:27.356369Z","steps":["trace[1889775121] 'agreement among raft nodes before linearized reading'  (duration: 537.492441ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T03:02:27.356439Z","caller":"traceutil/trace.go:171","msg":"trace[1863553400] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0; response_count:0; response_revision:22579; }","duration":"394.436238ms","start":"2026-04-20T03:02:26.961979Z","end":"2026-04-20T03:02:27.356415Z","steps":["trace[1863553400] 'agreement among raft nodes before linearized reading'  (duration: 394.246564ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T03:02:27.356528Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T03:02:26.961954Z","time spent":"394.55978ms","remote":"127.0.0.1:51834","response type":"/etcdserverpb.KV/Range","request count":0,"request size":152,"response count":0,"response size":29,"request content":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0\" "}
{"level":"warn","ts":"2026-04-20T03:02:27.356455Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T03:02:26.817744Z","time spent":"538.697556ms","remote":"127.0.0.1:46966","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":463,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-04-20T03:02:27.356502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.94345ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-04-20T03:02:27.356898Z","caller":"traceutil/trace.go:171","msg":"trace[1687297284] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:22579; }","duration":"299.696656ms","start":"2026-04-20T03:02:27.057136Z","end":"2026-04-20T03:02:27.356832Z","steps":["trace[1687297284] 'agreement among raft nodes before linearized reading'  (duration: 298.778447ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T03:02:27.355986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.905717ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-04-20T03:02:27.357148Z","caller":"traceutil/trace.go:171","msg":"trace[2043970080] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:22579; }","duration":"231.125372ms","start":"2026-04-20T03:02:27.125991Z","end":"2026-04-20T03:02:27.357116Z","steps":["trace[2043970080] 'agreement among raft nodes before linearized reading'  (duration: 229.864656ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T03:02:27.475205Z","caller":"traceutil/trace.go:171","msg":"trace[1967074974] transaction","detail":"{read_only:false; response_revision:22581; number_of_response:1; }","duration":"107.527015ms","start":"2026-04-20T03:02:27.367621Z","end":"2026-04-20T03:02:27.475148Z","steps":["trace[1967074974] 'process raft request'  (duration: 107.337071ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T03:02:51.293135Z","caller":"traceutil/trace.go:171","msg":"trace[936707769] transaction","detail":"{read_only:false; response_revision:22751; number_of_response:1; }","duration":"148.07937ms","start":"2026-04-20T03:02:51.145017Z","end":"2026-04-20T03:02:51.293097Z","steps":["trace[936707769] 'process raft request'  (duration: 147.870666ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T03:02:51.546161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.811563ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackmachines/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackmachines0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-04-20T03:02:51.546267Z","caller":"traceutil/trace.go:171","msg":"trace[1603976891] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackmachines/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackmachines0; response_count:0; response_revision:22751; }","duration":"131.983566ms","start":"2026-04-20T03:02:51.414258Z","end":"2026-04-20T03:02:51.546241Z","steps":["trace[1603976891] 'count revisions from in-memory index tree'  (duration: 131.708241ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T03:02:51.722423Z","caller":"traceutil/trace.go:171","msg":"trace[1160642092] transaction","detail":"{read_only:false; response_revision:22753; number_of_response:1; }","duration":"264.085405ms","start":"2026-04-20T03:02:51.458306Z","end":"2026-04-20T03:02:51.722392Z","steps":["trace[1160642092] 'process raft request'  (duration: 231.964681ms)","trace[1160642092] 'compare'  (duration: 31.642074ms)"],"step_count":2}
{"level":"info","ts":"2026-04-20T03:02:51.722731Z","caller":"traceutil/trace.go:171","msg":"trace[478300155] transaction","detail":"{read_only:false; response_revision:22754; number_of_response:1; }","duration":"259.343795ms","start":"2026-04-20T03:02:51.463356Z","end":"2026-04-20T03:02:51.7227Z","steps":["trace[478300155] 'process raft request'  (duration: 258.919346ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T03:02:51.722791Z","caller":"traceutil/trace.go:171","msg":"trace[1572927235] transaction","detail":"{read_only:false; response_revision:22755; number_of_response:1; }","duration":"256.044894ms","start":"2026-04-20T03:02:51.466706Z","end":"2026-04-20T03:02:51.722751Z","steps":["trace[1572927235] 'process raft request'  (duration: 255.8725ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T03:02:51.722943Z","caller":"traceutil/trace.go:171","msg":"trace[1729347580] linearizableReadLoop","detail":"{readStateIndex:23457; appliedIndex:23453; }","duration":"128.85612ms","start":"2026-04-20T03:02:51.594059Z","end":"2026-04-20T03:02:51.722915Z","steps":["trace[1729347580] 'read index received'  (duration: 96.177703ms)","trace[1729347580] 'applied index is now lower than readState.Index'  (duration: 32.675377ms)"],"step_count":2}
{"level":"info","ts":"2026-04-20T03:02:51.722986Z","caller":"traceutil/trace.go:171","msg":"trace[1382746015] transaction","detail":"{read_only:false; response_revision:22756; number_of_response:1; }","duration":"255.713287ms","start":"2026-04-20T03:02:51.467259Z","end":"2026-04-20T03:02:51.722972Z","steps":["trace[1382746015] 'process raft request'  (duration: 255.431191ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T03:02:51.723267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.185707ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"}
{"level":"info","ts":"2026-04-20T03:02:51.723318Z","caller":"traceutil/trace.go:171","msg":"trace[2088476005] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:22756; }","duration":"129.29678ms","start":"2026-04-20T03:02:51.594007Z","end":"2026-04-20T03:02:51.723303Z","steps":["trace[2088476005] 'agreement among raft nodes before linearized reading'  (duration: 129.073835ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T03:02:51.723333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.88408ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-04-20T03:02:51.723391Z","caller":"traceutil/trace.go:171","msg":"trace[1639367126] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:22756; }","duration":"128.974752ms","start":"2026-04-20T03:02:51.594401Z","end":"2026-04-20T03:02:51.723376Z","steps":["trace[1639367126] 'agreement among raft nodes before linearized reading'  (duration: 128.724227ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T03:02:51.723467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.815756ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/alertmanagerconfigs/\" range_end:\"/registry/monitoring.coreos.com/alertmanagerconfigs0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-04-20T03:02:51.72354Z","caller":"traceutil/trace.go:171","msg":"trace[673350309] range","detail":"{range_begin:/registry/monitoring.coreos.com/alertmanagerconfigs/; range_end:/registry/monitoring.coreos.com/alertmanagerconfigs0; response_count:0; response_revision:22756; }","duration":"120.027921ms","start":"2026-04-20T03:02:51.603474Z","end":"2026-04-20T03:02:51.723502Z","steps":["trace[673350309] 'agreement among raft nodes before linearized reading'  (duration: 119.825796ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T03:02:54.574981Z","caller":"traceutil/trace.go:171","msg":"trace[277910313] transaction","detail":"{read_only:false; response_revision:22780; number_of_response:1; }","duration":"102.698061ms","start":"2026-04-20T03:02:54.472253Z","end":"2026-04-20T03:02:54.574951Z","steps":["trace[277910313] 'process raft request'  (duration: 102.414265ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T03:03:11.855175Z","caller":"traceutil/trace.go:171","msg":"trace[500868115] linearizableReadLoop","detail":"{readStateIndex:23604; appliedIndex:23603; }","duration":"218.232707ms","start":"2026-04-20T03:03:11.636914Z","end":"2026-04-20T03:03:11.855147Z","steps":["trace[500868115] 'read index received'  (duration: 218.008932ms)","trace[500868115] 'applied index is now lower than readState.Index'  (duration: 222.395µs)"],"step_count":2}
{"level":"info","ts":"2026-04-20T03:03:11.855325Z","caller":"traceutil/trace.go:171","msg":"trace[190324370] transaction","detail":"{read_only:false; response_revision:22899; number_of_response:1; }","duration":"227.743031ms","start":"2026-04-20T03:03:11.627573Z","end":"2026-04-20T03:03:11.855316Z","steps":["trace[190324370] 'process raft request'  (duration: 227.391813ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T03:03:11.855566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.611325ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/addons.cluster.x-k8s.io/clusterresourcesets/\" range_end:\"/registry/addons.cluster.x-k8s.io/clusterresourcesets0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-04-20T03:03:11.855655Z","caller":"traceutil/trace.go:171","msg":"trace[1675497929] range","detail":"{range_begin:/registry/addons.cluster.x-k8s.io/clusterresourcesets/; range_end:/registry/addons.cluster.x-k8s.io/clusterresourcesets0; response_count:0; response_revision:22899; }","duration":"218.762498ms","start":"2026-04-20T03:03:11.636871Z","end":"2026-04-20T03:03:11.855634Z","steps":["trace[1675497929] 'agreement among raft nodes before linearized reading'  (duration: 218.534093ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T03:03:16.094089Z","caller":"traceutil/trace.go:171","msg":"trace[284927156] transaction","detail":"{read_only:false; response_revision:22931; number_of_response:1; }","duration":"190.24272ms","start":"2026-04-20T03:03:15.903822Z","end":"2026-04-20T03:03:16.094065Z","steps":["trace[284927156] 'process raft request'  (duration: 190.102347ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T03:03:16.094105Z","caller":"traceutil/trace.go:171","msg":"trace[162196627] transaction","detail":"{read_only:false; response_revision:22930; number_of_response:1; }","duration":"190.240769ms","start":"2026-04-20T03:03:15.903817Z","end":"2026-04-20T03:03:16.094057Z","steps":["trace[162196627] 'process raft request'  (duration: 170.267783ms)","trace[162196627] 'compare'  (duration: 19.533857ms)"],"step_count":2}
{"level":"info","ts":"2026-04-20T03:03:16.094403Z","caller":"traceutil/trace.go:171","msg":"trace[1645474894] transaction","detail":"{read_only:false; response_revision:22932; number_of_response:1; }","duration":"190.428973ms","start":"2026-04-20T03:03:15.903918Z","end":"2026-04-20T03:03:16.094347Z","steps":["trace[1645474894] 'process raft request'  (duration: 190.106677ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T03:03:16.094507Z","caller":"traceutil/trace.go:171","msg":"trace[140945432] linearizableReadLoop","detail":"{readStateIndex:23639; appliedIndex:23635; }","duration":"138.938385ms","start":"2026-04-20T03:03:15.955532Z","end":"2026-04-20T03:03:16.09447Z","steps":["trace[140945432] 'read index received'  (duration: 118.468399ms)","trace[140945432] 'applied index is now lower than readState.Index'  (duration: 20.468376ms)"],"step_count":2}
{"level":"info","ts":"2026-04-20T03:03:16.094547Z","caller":"traceutil/trace.go:171","msg":"trace[375864857] transaction","detail":"{read_only:false; response_revision:22933; number_of_response:1; }","duration":"187.266746ms","start":"2026-04-20T03:03:15.907224Z","end":"2026-04-20T03:03:16.094491Z","steps":["trace[375864857] 'process raft request'  (duration: 187.066462ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T03:03:16.094848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.277893ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"}
{"level":"warn","ts":"2026-04-20T03:03:16.094837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.692037ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"}
{"level":"warn","ts":"2026-04-20T03:03:16.094881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.604002ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"}
{"level":"info","ts":"2026-04-20T03:03:16.094892Z","caller":"traceutil/trace.go:171","msg":"trace[322653172] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:22933; }","duration":"139.408746ms","start":"2026-04-20T03:03:15.955466Z","end":"2026-04-20T03:03:16.094875Z","steps":["trace[322653172] 'agreement among raft nodes before linearized reading'  (duration: 139.184041ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T03:03:16.094921Z","caller":"traceutil/trace.go:171","msg":"trace[1851372756] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:22933; }","duration":"133.692983ms","start":"2026-04-20T03:03:15.961217Z","end":"2026-04-20T03:03:16.09491Z","steps":["trace[1851372756] 'agreement among raft nodes before linearized reading'  (duration: 133.504199ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T03:03:16.094925Z","caller":"traceutil/trace.go:171","msg":"trace[1758182050] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:22933; }","duration":"136.83229ms","start":"2026-04-20T03:03:15.95807Z","end":"2026-04-20T03:03:16.094902Z","steps":["trace[1758182050] 'agreement among raft nodes before linearized reading'  (duration: 136.609025ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T03:03:16.095114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.992693ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"}
{"level":"warn","ts":"2026-04-20T03:03:16.095126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.436931ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"}
{"level":"info","ts":"2026-04-20T03:03:16.095144Z","caller":"traceutil/trace.go:171","msg":"trace[540411990] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:22933; }","duration":"137.068455ms","start":"2026-04-20T03:03:15.958064Z","end":"2026-04-20T03:03:16.095132Z","steps":["trace[540411990] 'agreement among raft nodes before linearized reading'  (duration: 136.978383ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T03:03:16.095161Z","caller":"traceutil/trace.go:171","msg":"trace[1655972788] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:22933; }","duration":"136.507862ms","start":"2026-04-20T03:03:15.958644Z","end":"2026-04-20T03:03:16.095151Z","steps":["trace[1655972788] 'agreement among raft nodes before linearized reading'  (duration: 136.321948ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T03:03:16.337528Z","caller":"traceutil/trace.go:171","msg":"trace[1262128788] transaction","detail":"{read_only:false; response_revision:22938; number_of_response:1; }","duration":"237.340646ms","start":"2026-04-20T03:03:16.100157Z","end":"2026-04-20T03:03:16.337497Z","steps":["trace[1262128788] 'process raft request'  (duration: 237.284345ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T03:03:16.337892Z","caller":"traceutil/trace.go:171","msg":"trace[1241361353] transaction","detail":"{read_only:false; response_revision:22937; number_of_response:1; }","duration":"237.704183ms","start":"2026-04-20T03:03:16.100156Z","end":"2026-04-20T03:03:16.337861Z","steps":["trace[1241361353] 'process raft request'  (duration: 237.250334ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T03:03:16.337879Z","caller":"traceutil/trace.go:171","msg":"trace[472246504] transaction","detail":"{read_only:false; response_revision:22935; number_of_response:1; }","duration":"237.779815ms","start":"2026-04-20T03:03:16.100052Z","end":"2026-04-20T03:03:16.337832Z","steps":["trace[472246504] 'process raft request'  (duration: 194.324627ms)","trace[472246504] 'compare'  (duration: 42.755953ms)"],"step_count":2}
{"level":"info","ts":"2026-04-20T03:03:16.337969Z","caller":"traceutil/trace.go:171","msg":"trace[1732723649] transaction","detail":"{read_only:false; response_revision:22936; number_of_response:1; }","duration":"237.836095ms","start":"2026-04-20T03:03:16.100073Z","end":"2026-04-20T03:03:16.337909Z","steps":["trace[1732723649] 'process raft request'  (duration: 237.289004ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T03:03:20.163446Z","caller":"traceutil/trace.go:171","msg":"trace[1036354876] transaction","detail":"{read_only:false; response_revision:22958; number_of_response:1; }","duration":"204.107886ms","start":"2026-04-20T03:03:19.959317Z","end":"2026-04-20T03:03:20.163425Z","steps":["trace[1036354876] 'process raft request'  (duration: 203.928451ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T03:03:20.299569Z","caller":"traceutil/trace.go:171","msg":"trace[1041354172] transaction","detail":"{read_only:false; response_revision:22959; number_of_response:1; }","duration":"192.000426ms","start":"2026-04-20T03:03:20.107524Z","end":"2026-04-20T03:03:20.299524Z","steps":["trace[1041354172] 'process raft request'  (duration: 179.302486ms)","trace[1041354172] 'compare'  (duration: 12.21231ms)"],"step_count":2}
{"level":"info","ts":"2026-04-20T03:03:20.299619Z","caller":"traceutil/trace.go:171","msg":"trace[862008573] transaction","detail":"{read_only:false; response_revision:22960; number_of_response:1; }","duration":"190.445464ms","start":"2026-04-20T03:03:20.109137Z","end":"2026-04-20T03:03:20.299583Z","steps":["trace[862008573] 'process raft request'  (duration: 190.27962ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T03:03:20.299859Z","caller":"traceutil/trace.go:171","msg":"trace[2059282928] transaction","detail":"{read_only:false; response_revision:22962; number_of_response:1; }","duration":"189.33685ms","start":"2026-04-20T03:03:20.110512Z","end":"2026-04-20T03:03:20.299849Z","steps":["trace[2059282928] 'process raft request'  (duration: 189.192837ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T03:03:20.299857Z","caller":"traceutil/trace.go:171","msg":"trace[1299550717] linearizableReadLoop","detail":"{readStateIndex:23669; appliedIndex:23664; }","duration":"174.613136ms","start":"2026-04-20T03:03:20.125226Z","end":"2026-04-20T03:03:20.299839Z","steps":["trace[1299550717] 'read index received'  (duration: 38.129953ms)","trace[1299550717] 'applied index is now lower than readState.Index'  (duration: 136.481953ms)"],"step_count":2}
{"level":"info","ts":"2026-04-20T03:03:20.299881Z","caller":"traceutil/trace.go:171","msg":"trace[1475403315] transaction","detail":"{read_only:false; response_revision:22961; number_of_response:1; }","duration":"190.599988ms","start":"2026-04-20T03:03:20.109217Z","end":"2026-04-20T03:03:20.299817Z","steps":["trace[1475403315] 'process raft request'  (duration: 190.313052ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T03:03:20.300135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.896692ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-04-20T03:03:20.30018Z","caller":"traceutil/trace.go:171","msg":"trace[1702801435] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:22962; }","duration":"174.998564ms","start":"2026-04-20T03:03:20.125168Z","end":"2026-04-20T03:03:20.300167Z","steps":["trace[1702801435] 'agreement among raft nodes before linearized reading'  (duration: 174.873451ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T03:03:20.300226Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.785323ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"}
{"level":"info","ts":"2026-04-20T03:03:20.300263Z","caller":"traceutil/trace.go:171","msg":"trace[1616064535] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:22962; }","duration":"110.857605ms","start":"2026-04-20T03:03:20.189395Z","end":"2026-04-20T03:03:20.300252Z","steps":["trace[1616064535] 'agreement among raft nodes before linearized reading'  (duration: 110.679631ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T03:03:26.55776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.231694ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14933265287327429473 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:22989 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:465 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >>","response":"size:18"}
{"level":"info","ts":"2026-04-20T03:03:26.558036Z","caller":"traceutil/trace.go:171","msg":"trace[2129284092] linearizableReadLoop","detail":"{readStateIndex:23716; appliedIndex:23712; }","duration":"230.964719ms","start":"2026-04-20T03:03:26.327054Z","end":"2026-04-20T03:03:26.558018Z","steps":["trace[2129284092] 'read index received'  (duration: 18.475014ms)","trace[2129284092] 'applied index is now lower than readState.Index'  (duration: 212.488575ms)"],"step_count":2}
{"level":"info","ts":"2026-04-20T03:03:26.558017Z","caller":"traceutil/trace.go:171","msg":"trace[846859419] transaction","detail":"{read_only:false; response_revision:23006; number_of_response:1; }","duration":"237.663673ms","start":"2026-04-20T03:03:26.320315Z","end":"2026-04-20T03:03:26.557979Z","steps":["trace[846859419] 'process raft request'  (duration: 126.091701ms)","trace[846859419] 'compare'  (duration: 110.99397ms)"],"step_count":2}
{"level":"info","ts":"2026-04-20T03:03:26.558374Z","caller":"traceutil/trace.go:171","msg":"trace[665718625] transaction","detail":"{read_only:false; response_revision:23007; number_of_response:1; }","duration":"236.224591ms","start":"2026-04-20T03:03:26.322137Z","end":"2026-04-20T03:03:26.558362Z","steps":["trace[665718625] 'process raft request'  (duration: 235.737761ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T03:03:26.558389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.314236ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"}
{"level":"info","ts":"2026-04-20T03:03:26.558432Z","caller":"traceutil/trace.go:171","msg":"trace[934074951] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:23008; }","duration":"231.374347ms","start":"2026-04-20T03:03:26.327045Z","end":"2026-04-20T03:03:26.558419Z","steps":["trace[934074951] 'agreement among raft nodes before linearized reading'  (duration: 231.198413ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T03:03:26.558545Z","caller":"traceutil/trace.go:171","msg":"trace[1334876525] transaction","detail":"{read_only:false; response_revision:23008; number_of_response:1; }","duration":"235.376403ms","start":"2026-04-20T03:03:26.323158Z","end":"2026-04-20T03:03:26.558534Z","steps":["trace[1334876525] 'process raft request'  (duration: 234.813492ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T03:03:26.558623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.479474ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-04-20T03:03:26.558728Z","caller":"traceutil/trace.go:171","msg":"trace[1405213749] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:23008; }","duration":"175.619957ms","start":"2026-04-20T03:03:26.38305Z","end":"2026-04-20T03:03:26.55867Z","steps":["trace[1405213749] 'agreement among raft nodes before linearized reading'  (duration: 175.328531ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T03:03:26.558901Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.780048ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"}
{"level":"info","ts":"2026-04-20T03:03:26.558974Z","caller":"traceutil/trace.go:171","msg":"trace[167227540] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:23008; }","duration":"173.915642ms","start":"2026-04-20T03:03:26.385038Z","end":"2026-04-20T03:03:26.558953Z","steps":["trace[167227540] 'agreement among raft nodes before linearized reading'  (duration: 173.532213ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T03:03:26.559168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.4094ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"}
{"level":"info","ts":"2026-04-20T03:03:26.559309Z","caller":"traceutil/trace.go:171","msg":"trace[351187540] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:23008; }","duration":"173.559894ms","start":"2026-04-20T03:03:26.385734Z","end":"2026-04-20T03:03:26.559294Z","steps":["trace[351187540] 'agreement among raft nodes before linearized reading'  (duration: 172.848608ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T03:03:26.559084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.773488ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"}
{"level":"info","ts":"2026-04-20T03:03:26.559852Z","caller":"traceutil/trace.go:171","msg":"trace[1242298679] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:23008; }","duration":"174.598235ms","start":"2026-04-20T03:03:26.385225Z","end":"2026-04-20T03:03:26.559823Z","steps":["trace[1242298679] 'agreement among raft nodes before linearized reading'  (duration: 173.165074ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T03:03:26.776118Z","caller":"traceutil/trace.go:171","msg":"trace[784901615] transaction","detail":"{read_only:false; response_revision:23010; number_of_response:1; }","duration":"212.555957ms","start":"2026-04-20T03:03:26.563535Z","end":"2026-04-20T03:03:26.776091Z","steps":["trace[784901615] 'process raft request'  (duration: 209.023752ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T03:03:26.776409Z","caller":"traceutil/trace.go:171","msg":"trace[224290860] transaction","detail":"{read_only:false; response_revision:23011; number_of_response:1; }","duration":"212.826762ms","start":"2026-04-20T03:03:26.563558Z","end":"2026-04-20T03:03:26.776385Z","steps":["trace[224290860] 'process raft request'  (duration: 212.446204ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T03:03:26.776623Z","caller":"traceutil/trace.go:171","msg":"trace[1303172225] transaction","detail":"{read_only:false; response_revision:23012; number_of_response:1; }","duration":"213.028457ms","start":"2026-04-20T03:03:26.563585Z","end":"2026-04-20T03:03:26.776614Z","steps":["trace[1303172225] 'process raft request'  (duration: 212.72916ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T03:03:26.776736Z","caller":"traceutil/trace.go:171","msg":"trace[1218023146] transaction","detail":"{read_only:false; response_revision:23013; number_of_response:1; }","duration":"212.887963ms","start":"2026-04-20T03:03:26.563841Z","end":"2026-04-20T03:03:26.776729Z","steps":["trace[1218023146] 'process raft request'  (duration: 212.74082ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T03:03:33.721594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.486976ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14933265287327429583 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:23043 > success:<request_put:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" value_size:442 >> failure:<request_range:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" > >>","response":"size:18"}
{"level":"info","ts":"2026-04-20T03:03:33.721689Z","caller":"traceutil/trace.go:171","msg":"trace[1446508151] linearizableReadLoop","detail":"{readStateIndex:23768; appliedIndex:23767; }","duration":"129.573624ms","start":"2026-04-20T03:03:33.5921Z","end":"2026-04-20T03:03:33.721673Z","steps":["trace[1446508151] 'read index received'  (duration: 47.311µs)","trace[1446508151] 'applied index is now lower than readState.Index'  (duration: 129.525023ms)"],"step_count":2}
{"level":"info","ts":"2026-04-20T03:03:33.721775Z","caller":"traceutil/trace.go:171","msg":"trace[1384001461] transaction","detail":"{read_only:false; response_revision:23059; number_of_response:1; }","duration":"184.468936ms","start":"2026-04-20T03:03:33.537298Z","end":"2026-04-20T03:03:33.721767Z","steps":["trace[1384001461] 'process raft request'  (duration: 30.49547ms)","trace[1384001461] 'compare'  (duration: 153.21043ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-20T03:03:33.721938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.841791ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/roles/\" range_end:\"/registry/openstack.k-orc.cloud/roles0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-04-20T03:03:33.721968Z","caller":"traceutil/trace.go:171","msg":"trace[1091185447] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/roles/; range_end:/registry/openstack.k-orc.cloud/roles0; response_count:0; response_revision:23059; }","duration":"129.914842ms","start":"2026-04-20T03:03:33.592043Z","end":"2026-04-20T03:03:33.721958Z","steps":["trace[1091185447] 'agreement among raft nodes before linearized reading'  (duration: 129.859541ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T03:03:43.900987Z","caller":"traceutil/trace.go:171","msg":"trace[1750496897] transaction","detail":"{read_only:false; response_revision:23134; number_of_response:1; }","duration":"108.010444ms","start":"2026-04-20T03:03:43.792948Z","end":"2026-04-20T03:03:43.900959Z","steps":["trace[1750496897] 'process raft request'  (duration: 107.725738ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T03:03:44.873431Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.503316ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"}
{"level":"info","ts":"2026-04-20T03:03:44.873542Z","caller":"traceutil/trace.go:171","msg":"trace[1391809228] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:23143; }","duration":"145.640618ms","start":"2026-04-20T03:03:44.727872Z","end":"2026-04-20T03:03:44.873513Z","steps":["trace[1391809228] 'range keys from in-memory index tree'  (duration: 145.317572ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T03:03:48.911899Z","caller":"traceutil/trace.go:171","msg":"trace[1188648069] transaction","detail":"{read_only:false; response_revision:23173; number_of_response:1; }","duration":"132.640471ms","start":"2026-04-20T03:03:48.779208Z","end":"2026-04-20T03:03:48.911848Z","steps":["trace[1188648069] 'process raft request'  (duration: 132.389186ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T03:03:58.677081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.6106ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/passwords/\" range_end:\"/registry/secretgen.k14s.io/passwords0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-04-20T03:03:58.677181Z","caller":"traceutil/trace.go:171","msg":"trace[64436680] range","detail":"{range_begin:/registry/secretgen.k14s.io/passwords/; range_end:/registry/secretgen.k14s.io/passwords0; response_count:0; response_revision:23248; }","duration":"228.773002ms","start":"2026-04-20T03:03:58.448383Z","end":"2026-04-20T03:03:58.677156Z","steps":["trace[64436680] 'count revisions from in-memory index tree'  (duration: 228.450616ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T03:03:58.677474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.829973ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/securitygroups/\" range_end:\"/registry/openstack.k-orc.cloud/securitygroups0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-04-20T03:03:58.677507Z","caller":"traceutil/trace.go:171","msg":"trace[753900390] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/securitygroups/; range_end:/registry/openstack.k-orc.cloud/securitygroups0; response_count:0; response_revision:23248; }","duration":"227.901444ms","start":"2026-04-20T03:03:58.449594Z","end":"2026-04-20T03:03:58.677495Z","steps":["trace[753900390] 'count revisions from in-memory index tree'  (duration: 227.71979ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T03:03:58.678549Z","caller":"traceutil/trace.go:171","msg":"trace[1675840771] linearizableReadLoop","detail":"{readStateIndex:23964; appliedIndex:23963; }","duration":"126.002839ms","start":"2026-04-20T03:03:58.552535Z","end":"2026-04-20T03:03:58.678538Z","steps":["trace[1675840771] 'read index received'  (duration: 43.051499ms)","trace[1675840771] 'applied index is now lower than readState.Index'  (duration: 82.95052ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-20T03:03:58.678658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.126751ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackmachinetemplates/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackmachinetemplates0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-04-20T03:03:58.678699Z","caller":"traceutil/trace.go:171","msg":"trace[83683051] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackmachinetemplates/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackmachinetemplates0; response_count:0; response_revision:23249; }","duration":"126.201103ms","start":"2026-04-20T03:03:58.552475Z","end":"2026-04-20T03:03:58.678676Z","steps":["trace[83683051] 'agreement among raft nodes before linearized reading'  (duration: 126.106051ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T03:03:58.67884Z","caller":"traceutil/trace.go:171","msg":"trace[1014071935] transaction","detail":"{read_only:false; response_revision:23249; number_of_response:1; }","duration":"186.284895ms","start":"2026-04-20T03:03:58.492521Z","end":"2026-04-20T03:03:58.678806Z","steps":["trace[1014071935] 'process raft request'  (duration: 103.033109ms)","trace[1014071935] 'compare'  (duration: 82.628943ms)"],"step_count":2}
{"level":"info","ts":"2026-04-20T03:03:58.966492Z","caller":"traceutil/trace.go:171","msg":"trace[1041820354] transaction","detail":"{read_only:false; response_revision:23250; number_of_response:1; }","duration":"260.709133ms","start":"2026-04-20T03:03:58.705721Z","end":"2026-04-20T03:03:58.96643Z","steps":["trace[1041820354] 'process raft request'  (duration: 246.218114ms)","trace[1041820354] 'compare'  (duration: 14.338496ms)"],"step_count":2}
{"level":"info","ts":"2026-04-20T03:03:59.010531Z","caller":"traceutil/trace.go:171","msg":"trace[725768898] linearizableReadLoop","detail":"{readStateIndex:23967; appliedIndex:23964; }","duration":"265.093678ms","start":"2026-04-20T03:03:58.745404Z","end":"2026-04-20T03:03:59.010497Z","steps":["trace[725768898] 'read index received'  (duration: 206.493397ms)","trace[725768898] 'applied index is now lower than readState.Index'  (duration: 58.598861ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-20T03:03:59.010664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.238561ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/images/\" range_end:\"/registry/openstack.k-orc.cloud/images0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-04-20T03:03:59.010702Z","caller":"traceutil/trace.go:171","msg":"trace[1164498703] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/images/; range_end:/registry/openstack.k-orc.cloud/images0; response_count:0; response_revision:23252; }","duration":"265.327283ms","start":"2026-04-20T03:03:58.745358Z","end":"2026-04-20T03:03:59.010686Z","steps":["trace[1164498703] 'agreement among raft nodes before linearized reading'  (duration: 265.243751ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T03:03:59.010681Z","caller":"traceutil/trace.go:171","msg":"trace[237418699] transaction","detail":"{read_only:false; response_revision:23252; number_of_response:1; }","duration":"299.333989ms","start":"2026-04-20T03:03:58.711296Z","end":"2026-04-20T03:03:59.01063Z","steps":["trace[237418699] 'process raft request'  (duration: 299.155955ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T03:03:59.01082Z","caller":"traceutil/trace.go:171","msg":"trace[647254222] transaction","detail":"{read_only:false; response_revision:23251; number_of_response:1; }","duration":"302.794332ms","start":"2026-04-20T03:03:58.707786Z","end":"2026-04-20T03:03:59.01058Z","steps":["trace[647254222] 'process raft request'  (duration: 302.505155ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T03:03:59.011076Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T03:03:58.707779Z","time spent":"303.116988ms","remote":"127.0.0.1:46966","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:23235 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:465 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"info","ts":"2026-04-20T03:03:59.148277Z","caller":"traceutil/trace.go:171","msg":"trace[1565197522] linearizableReadLoop","detail":"{readStateIndex:23969; appliedIndex:23967; }","duration":"127.397119ms","start":"2026-04-20T03:03:59.020851Z","end":"2026-04-20T03:03:59.148248Z","steps":["trace[1565197522] 'read index received'  (duration: 85.839502ms)","trace[1565197522] 'applied index is now lower than readState.Index'  (duration: 41.556247ms)"],"step_count":2}
{"level":"info","ts":"2026-04-20T03:03:59.148892Z","caller":"traceutil/trace.go:171","msg":"trace[687516589] transaction","detail":"{read_only:false; response_revision:23253; number_of_response:1; }","duration":"134.234095ms","start":"2026-04-20T03:03:59.0146Z","end":"2026-04-20T03:03:59.148834Z","steps":["trace[687516589] 'process raft request'  (duration: 91.869491ms)","trace[687516589] 'compare'  (duration: 41.605658ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-20T03:03:59.148736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.854959ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"}
{"level":"info","ts":"2026-04-20T03:03:59.149315Z","caller":"traceutil/trace.go:171","msg":"trace[844885306] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:23254; }","duration":"128.475052ms","start":"2026-04-20T03:03:59.020794Z","end":"2026-04-20T03:03:59.149269Z","steps":["trace[844885306] 'agreement among raft nodes before linearized reading'  (duration: 127.714466ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T03:03:59.148829Z","caller":"traceutil/trace.go:171","msg":"trace[2086905264] transaction","detail":"{read_only:false; response_revision:23254; number_of_response:1; }","duration":"133.794035ms","start":"2026-04-20T03:03:59.015014Z","end":"2026-04-20T03:03:59.148809Z","steps":["trace[2086905264] 'process raft request'  (duration: 133.187482ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T03:03:59.151068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.436382ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"}
{"level":"info","ts":"2026-04-20T03:03:59.151156Z","caller":"traceutil/trace.go:171","msg":"trace[661879773] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:23254; }","duration":"129.538884ms","start":"2026-04-20T03:03:59.021601Z","end":"2026-04-20T03:03:59.15114Z","steps":["trace[661879773] 'agreement among raft nodes before linearized reading'  (duration: 129.33486ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T03:03:59.151142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.124007ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"}
{"level":"warn","ts":"2026-04-20T03:03:59.15143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.577384ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-04-20T03:03:59.151566Z","caller":"traceutil/trace.go:171","msg":"trace[1235838394] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:23254; }","duration":"121.737127ms","start":"2026-04-20T03:03:59.029788Z","end":"2026-04-20T03:03:59.151525Z","steps":["trace[1235838394] 'agreement among raft nodes before linearized reading'  (duration: 121.359929ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T03:03:59.151549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.079373ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"}
{"level":"info","ts":"2026-04-20T03:03:59.151663Z","caller":"traceutil/trace.go:171","msg":"trace[390100762] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:23254; }","duration":"120.274366ms","start":"2026-04-20T03:03:59.031361Z","end":"2026-04-20T03:03:59.151635Z","steps":["trace[390100762] 'agreement among raft nodes before linearized reading'  (duration: 119.636503ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T03:03:59.151614Z","caller":"traceutil/trace.go:171","msg":"trace[1252627984] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:23254; }","duration":"115.486135ms","start":"2026-04-20T03:03:59.035969Z","end":"2026-04-20T03:03:59.151455Z","steps":["trace[1252627984] 'agreement among raft nodes before linearized reading'  (duration: 114.980544ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-20T03:04:00.275365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.03003ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-04-20T03:04:00.275465Z","caller":"traceutil/trace.go:171","msg":"trace[979396551] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:23260; }","duration":"148.188662ms","start":"2026-04-20T03:04:00.127255Z","end":"2026-04-20T03:04:00.275444Z","steps":["trace[979396551] 'range keys from in-memory index tree'  (duration: 147.946467ms)"],"step_count":1}
{"level":"info","ts":"2026-04-20T03:04:10.823865Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":20751}
{"level":"info","ts":"2026-04-20T03:04:10.986015Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":20751,"took":"152.193769ms","hash":2076893643,"current-db-size-bytes":59936768,"current-db-size":"60 MB","current-db-size-in-use-bytes":33685504,"current-db-size-in-use":"34 MB"}
{"level":"info","ts":"2026-04-20T03:04:10.986108Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2076893643,"revision":20751,"compact-revision":17519}
{"level":"info","ts":"2026-04-20T03:07:59.076651Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-0000000000006514.wal"}
{"level":"info","ts":"2026-04-20T03:09:10.830538Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":23362}
{"level":"info","ts":"2026-04-20T03:09:11.002373Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":23362,"took":"165.215765ms","hash":190701550,"current-db-size-bytes":59936768,"current-db-size":"60 MB","current-db-size-in-use-bytes":32600064,"current-db-size-in-use":"33 MB"}
{"level":"info","ts":"2026-04-20T03:09:11.00247Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":190701550,"revision":23362,"compact-revision":20751}
{"level":"info","ts":"2026-04-20T03:14:10.837225Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":25634}
{"level":"info","ts":"2026-04-20T03:14:10.971028Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":25634,"took":"129.138165ms","hash":2193992107,"current-db-size-bytes":59936768,"current-db-size":"60 MB","current-db-size-in-use-bytes":32071680,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-04-20T03:14:10.971109Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2193992107,"revision":25634,"compact-revision":23362}