{"level":"warn","ts":"2026-03-31T22:20:43.881374Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-03-31T22:20:43.881471Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.123:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.123:2380","--initial-cluster=instance=https://199.19.213.123:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.123:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.123: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-03-31T22:20:43.881537Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-03-31T22:20:43.881551Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.123:2380"]}
{"level":"info","ts":"2026-03-31T22:20:43.881569Z","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-03-31T22:20:43.882219Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.123:2379"]}
{"level":"info","ts":"2026-03-31T22:20:43.88234Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.123:2380"],"listen-peer-urls":["https://199.19.213.123:2380"],"advertise-client-urls":["https://199.19.213.123:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.123:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.123: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-03-31T22:20:43.888541Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.989192ms"}
{"level":"info","ts":"2026-03-31T22:20:43.897095Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"3e4829a3cabe4fce","cluster-id":"b469cfed817d8605"}
{"level":"info","ts":"2026-03-31T22:20:43.897192Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3e4829a3cabe4fce switched to configuration voters=()"}
{"level":"info","ts":"2026-03-31T22:20:43.897215Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3e4829a3cabe4fce became follower at term 0"}
{"level":"info","ts":"2026-03-31T22:20:43.89723Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 3e4829a3cabe4fce [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-03-31T22:20:43.897244Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3e4829a3cabe4fce became follower at term 1"}
{"level":"info","ts":"2026-03-31T22:20:43.897287Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3e4829a3cabe4fce switched to configuration voters=(4487882812132577230)"}
{"level":"warn","ts":"2026-03-31T22:20:43.907625Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-03-31T22:20:43.909954Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-03-31T22:20:43.913096Z","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-03-31T22:20:43.915658Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"3e4829a3cabe4fce","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-03-31T22:20:43.915805Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"3e4829a3cabe4fce","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-03-31T22:20:43.916038Z","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-03-31T22:20:43.916236Z","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-03-31T22:20:43.916312Z","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-03-31T22:20:43.918243Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3e4829a3cabe4fce switched to configuration voters=(4487882812132577230)"}
{"level":"info","ts":"2026-03-31T22:20:43.918521Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"b469cfed817d8605","local-member-id":"3e4829a3cabe4fce","added-peer-id":"3e4829a3cabe4fce","added-peer-peer-urls":["https://199.19.213.123:2380"]}
{"level":"info","ts":"2026-03-31T22:20:43.922199Z","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-03-31T22:20:43.922402Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.123:2380"}
{"level":"info","ts":"2026-03-31T22:20:43.922471Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.123:2380"}
{"level":"info","ts":"2026-03-31T22:20:43.922714Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"3e4829a3cabe4fce","initial-advertise-peer-urls":["https://199.19.213.123:2380"],"listen-peer-urls":["https://199.19.213.123:2380"],"advertise-client-urls":["https://199.19.213.123:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.123:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-03-31T22:20:43.922786Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-03-31T22:20:44.197791Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3e4829a3cabe4fce is starting a new election at term 1"}
{"level":"info","ts":"2026-03-31T22:20:44.197868Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3e4829a3cabe4fce became pre-candidate at term 1"}
{"level":"info","ts":"2026-03-31T22:20:44.197894Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3e4829a3cabe4fce received MsgPreVoteResp from 3e4829a3cabe4fce at term 1"}
{"level":"info","ts":"2026-03-31T22:20:44.197914Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3e4829a3cabe4fce became candidate at term 2"}
{"level":"info","ts":"2026-03-31T22:20:44.197927Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3e4829a3cabe4fce received MsgVoteResp from 3e4829a3cabe4fce at term 2"}
{"level":"info","ts":"2026-03-31T22:20:44.197949Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3e4829a3cabe4fce became leader at term 2"}
{"level":"info","ts":"2026-03-31T22:20:44.19797Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 3e4829a3cabe4fce elected leader 3e4829a3cabe4fce at term 2"}
{"level":"info","ts":"2026-03-31T22:20:44.201033Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"3e4829a3cabe4fce","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.123:2379]}","request-path":"/0/members/3e4829a3cabe4fce/attributes","cluster-id":"b469cfed817d8605","publish-timeout":"7s"}
{"level":"info","ts":"2026-03-31T22:20:44.201312Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-31T22:20:44.201245Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-31T22:20:44.201387Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-03-31T22:20:44.201424Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-03-31T22:20:44.201611Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-31T22:20:44.202776Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"b469cfed817d8605","local-member-id":"3e4829a3cabe4fce","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-31T22:20:44.20287Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-31T22:20:44.202901Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-31T22:20:44.20659Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-03-31T22:20:44.206648Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.123:2379"}
{"level":"info","ts":"2026-03-31T22:20:47.606313Z","caller":"traceutil/trace.go:171","msg":"trace[1617858609] transaction","detail":"{read_only:false; response_revision:181; number_of_response:1; }","duration":"144.598256ms","start":"2026-03-31T22:20:47.461682Z","end":"2026-03-31T22:20:47.60628Z","steps":["trace[1617858609] 'process raft request'  (duration: 142.309691ms)"],"step_count":1}
{"level":"info","ts":"2026-03-31T22:20:53.215003Z","caller":"traceutil/trace.go:171","msg":"trace[832134500] transaction","detail":"{read_only:false; response_revision:289; number_of_response:1; }","duration":"157.101182ms","start":"2026-03-31T22:20:53.057863Z","end":"2026-03-31T22:20:53.214964Z","steps":["trace[832134500] 'process raft request'  (duration: 156.57608ms)"],"step_count":1}
{"level":"info","ts":"2026-03-31T22:21:00.619624Z","caller":"traceutil/trace.go:171","msg":"trace[1780951021] transaction","detail":"{read_only:false; response_revision:369; number_of_response:1; }","duration":"185.272722ms","start":"2026-03-31T22:21:00.434315Z","end":"2026-03-31T22:21:00.619587Z","steps":["trace[1780951021] 'process raft request'  (duration: 184.991635ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-31T22:21:15.247881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.532494ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-03-31T22:21:15.248036Z","caller":"traceutil/trace.go:171","msg":"trace[1836095928] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:468; }","duration":"124.763929ms","start":"2026-03-31T22:21:15.123243Z","end":"2026-03-31T22:21:15.248007Z","steps":["trace[1836095928] 'range keys from in-memory index tree'  (duration: 124.39303ms)"],"step_count":1}
{"level":"info","ts":"2026-03-31T22:21:22.603359Z","caller":"traceutil/trace.go:171","msg":"trace[89070452] linearizableReadLoop","detail":"{readStateIndex:598; appliedIndex:597; }","duration":"132.110442ms","start":"2026-03-31T22:21:22.471214Z","end":"2026-03-31T22:21:22.603324Z","steps":["trace[89070452] 'read index received'  (duration: 131.21025ms)","trace[89070452] 'applied index is now lower than readState.Index'  (duration: 899.082µs)"],"step_count":2}
{"level":"info","ts":"2026-03-31T22:21:22.603576Z","caller":"traceutil/trace.go:171","msg":"trace[292948339] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"242.332221ms","start":"2026-03-31T22:21:22.361228Z","end":"2026-03-31T22:21:22.60356Z","steps":["trace[292948339] 'process raft request'  (duration: 241.44769ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-31T22:21:22.603884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.650355ms","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-03-31T22:21:22.60399Z","caller":"traceutil/trace.go:171","msg":"trace[142457321] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:578; }","duration":"132.828729ms","start":"2026-03-31T22:21:22.471134Z","end":"2026-03-31T22:21:22.603963Z","steps":["trace[142457321] 'agreement among raft nodes before linearized reading'  (duration: 132.533302ms)"],"step_count":1}
{"level":"info","ts":"2026-03-31T22:21:23.121822Z","caller":"traceutil/trace.go:171","msg":"trace[1439987975] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"460.671344ms","start":"2026-03-31T22:21:22.661099Z","end":"2026-03-31T22:21:23.12177Z","steps":["trace[1439987975] 'process raft request'  (duration: 460.4929ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-31T22:21:23.122282Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T22:21:22.661069Z","time spent":"460.858699ms","remote":"127.0.0.1:51596","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" mod_revision:0 > success:<request_put:<key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" value_size:1527 >> failure:<>"}
{"level":"info","ts":"2026-03-31T22:21:23.425769Z","caller":"traceutil/trace.go:171","msg":"trace[1336715114] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"764.435422ms","start":"2026-03-31T22:21:22.661288Z","end":"2026-03-31T22:21:23.425723Z","steps":["trace[1336715114] 'process raft request'  (duration: 764.167855ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-31T22:21:23.426136Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T22:21:22.661264Z","time spent":"764.593515ms","remote":"127.0.0.1:51298","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-xhsnr\" mod_revision:462 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-xhsnr\" value_size:17085 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-xhsnr\" > >"}
{"level":"info","ts":"2026-03-31T22:21:23.456127Z","caller":"traceutil/trace.go:171","msg":"trace[456191862] linearizableReadLoop","detail":"{readStateIndex:601; appliedIndex:599; }","duration":"733.991054ms","start":"2026-03-31T22:21:22.722106Z","end":"2026-03-31T22:21:23.456097Z","steps":["trace[456191862] 'read index received'  (duration: 399.567325ms)","trace[456191862] 'applied index is now lower than readState.Index'  (duration: 334.421349ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-31T22:21:23.456381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.457875ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-31T22:21:23.456443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"734.315732ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"warn","ts":"2026-03-31T22:21:23.45645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.443083ms","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-03-31T22:21:23.456519Z","caller":"traceutil/trace.go:171","msg":"trace[641276436] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:581; }","duration":"144.548536ms","start":"2026-03-31T22:21:23.311955Z","end":"2026-03-31T22:21:23.456504Z","steps":["trace[641276436] 'agreement among raft nodes before linearized reading'  (duration: 144.380872ms)"],"step_count":1}
{"level":"info","ts":"2026-03-31T22:21:23.456514Z","caller":"traceutil/trace.go:171","msg":"trace[564552248] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:581; }","duration":"734.432765ms","start":"2026-03-31T22:21:22.72206Z","end":"2026-03-31T22:21:23.456493Z","steps":["trace[564552248] 'agreement among raft nodes before linearized reading'  (duration: 734.212079ms)"],"step_count":1}
{"level":"info","ts":"2026-03-31T22:21:23.456458Z","caller":"traceutil/trace.go:171","msg":"trace[1171959264] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:581; }","duration":"324.566477ms","start":"2026-03-31T22:21:23.131871Z","end":"2026-03-31T22:21:23.456437Z","steps":["trace[1171959264] 'agreement among raft nodes before linearized reading'  (duration: 324.452065ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-31T22:21:23.456574Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T22:21:22.722041Z","time spent":"734.520556ms","remote":"127.0.0.1:51372","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-03-31T22:21:23.456683Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T22:21:23.131851Z","time spent":"324.786643ms","remote":"127.0.0.1:51350","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "}
{"level":"info","ts":"2026-03-31T22:21:38.648831Z","caller":"traceutil/trace.go:171","msg":"trace[56996702] linearizableReadLoop","detail":"{readStateIndex:766; appliedIndex:765; }","duration":"140.003548ms","start":"2026-03-31T22:21:38.508803Z","end":"2026-03-31T22:21:38.648806Z","steps":["trace[56996702] 'read index received'  (duration: 139.831594ms)","trace[56996702] 'applied index is now lower than readState.Index'  (duration: 170.814µs)"],"step_count":2}
{"level":"info","ts":"2026-03-31T22:21:38.648924Z","caller":"traceutil/trace.go:171","msg":"trace[228724603] transaction","detail":"{read_only:false; response_revision:741; number_of_response:1; }","duration":"155.930725ms","start":"2026-03-31T22:21:38.492971Z","end":"2026-03-31T22:21:38.648902Z","steps":["trace[228724603] 'process raft request'  (duration: 155.690358ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-31T22:21:38.648961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.135962ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-31T22:21:38.648994Z","caller":"traceutil/trace.go:171","msg":"trace[1147167539] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:741; }","duration":"140.214874ms","start":"2026-03-31T22:21:38.508768Z","end":"2026-03-31T22:21:38.648983Z","steps":["trace[1147167539] 'agreement among raft nodes before linearized reading'  (duration: 140.144963ms)"],"step_count":1}
{"level":"info","ts":"2026-03-31T22:21:51.963997Z","caller":"traceutil/trace.go:171","msg":"trace[1121200649] transaction","detail":"{read_only:false; response_revision:903; number_of_response:1; }","duration":"213.0823ms","start":"2026-03-31T22:21:51.750879Z","end":"2026-03-31T22:21:51.963962Z","steps":["trace[1121200649] 'process raft request'  (duration: 210.655023ms)"],"step_count":1}
{"level":"info","ts":"2026-03-31T22:21:51.965304Z","caller":"traceutil/trace.go:171","msg":"trace[171547872] transaction","detail":"{read_only:false; response_revision:904; number_of_response:1; }","duration":"210.889738ms","start":"2026-03-31T22:21:51.754387Z","end":"2026-03-31T22:21:51.965276Z","steps":["trace[171547872] 'process raft request'  (duration: 210.664803ms)"],"step_count":1}
{"level":"info","ts":"2026-03-31T22:22:36.374227Z","caller":"traceutil/trace.go:171","msg":"trace[1013767692] linearizableReadLoop","detail":"{readStateIndex:1467; appliedIndex:1466; }","duration":"181.874551ms","start":"2026-03-31T22:22:36.192327Z","end":"2026-03-31T22:22:36.374202Z","steps":["trace[1013767692] 'read index received'  (duration: 132.763904ms)","trace[1013767692] 'applied index is now lower than readState.Index'  (duration: 49.109587ms)"],"step_count":2}
{"level":"info","ts":"2026-03-31T22:22:36.374301Z","caller":"traceutil/trace.go:171","msg":"trace[1238028536] transaction","detail":"{read_only:false; response_revision:1424; number_of_response:1; }","duration":"216.230959ms","start":"2026-03-31T22:22:36.158029Z","end":"2026-03-31T22:22:36.37426Z","steps":["trace[1238028536] 'process raft request'  (duration: 167.154982ms)","trace[1238028536] 'compare'  (duration: 48.911643ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-31T22:22:36.374501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.161828ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-03-31T22:22:36.374588Z","caller":"traceutil/trace.go:171","msg":"trace[658291423] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1424; }","duration":"182.302072ms","start":"2026-03-31T22:22:36.192263Z","end":"2026-03-31T22:22:36.374565Z","steps":["trace[658291423] 'agreement among raft nodes before linearized reading'  (duration: 182.045316ms)"],"step_count":1}
{"level":"info","ts":"2026-03-31T22:23:00.815497Z","caller":"traceutil/trace.go:171","msg":"trace[1258996275] linearizableReadLoop","detail":"{readStateIndex:1902; appliedIndex:1901; }","duration":"303.316136ms","start":"2026-03-31T22:23:00.512141Z","end":"2026-03-31T22:23:00.815457Z","steps":["trace[1258996275] 'read index received'  (duration: 301.193477ms)","trace[1258996275] 'applied index is now lower than readState.Index'  (duration: 2.120179ms)"],"step_count":2}
{"level":"info","ts":"2026-03-31T22:23:00.815983Z","caller":"traceutil/trace.go:171","msg":"trace[265286611] transaction","detail":"{read_only:false; response_revision:1832; number_of_response:1; }","duration":"348.53634ms","start":"2026-03-31T22:23:00.467171Z","end":"2026-03-31T22:23:00.815708Z","steps":["trace[265286611] 'process raft request'  (duration: 346.238117ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-31T22:23:00.816435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.301564ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"warn","ts":"2026-03-31T22:23:00.816438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.268659ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-31T22:23:00.8165Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T22:23:00.467139Z","time spent":"348.89904ms","remote":"127.0.0.1:51372","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:1788 > 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":"info","ts":"2026-03-31T22:23:00.816534Z","caller":"traceutil/trace.go:171","msg":"trace[1624247666] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1832; }","duration":"281.453587ms","start":"2026-03-31T22:23:00.535057Z","end":"2026-03-31T22:23:00.816511Z","steps":["trace[1624247666] 'agreement among raft nodes before linearized reading'  (duration: 281.184521ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-31T22:23:00.81653Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.080767ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"}
{"level":"info","ts":"2026-03-31T22:23:00.816567Z","caller":"traceutil/trace.go:171","msg":"trace[986388676] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1832; }","duration":"304.473575ms","start":"2026-03-31T22:23:00.512059Z","end":"2026-03-31T22:23:00.816532Z","steps":["trace[986388676] 'agreement among raft nodes before linearized reading'  (duration: 304.173438ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-31T22:23:00.816642Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T22:23:00.512023Z","time spent":"304.609918ms","remote":"127.0.0.1:51118","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-03-31T22:23:00.816718Z","caller":"traceutil/trace.go:171","msg":"trace[272193478] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1832; }","duration":"206.248731ms","start":"2026-03-31T22:23:00.61037Z","end":"2026-03-31T22:23:00.816618Z","steps":["trace[272193478] 'agreement among raft nodes before linearized reading'  (duration: 205.923583ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-31T22:23:01.275775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.083242ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5750706698106832821 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:1812 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-31T22:23:01.2761Z","caller":"traceutil/trace.go:171","msg":"trace[427377543] linearizableReadLoop","detail":"{readStateIndex:1905; appliedIndex:1904; }","duration":"137.777484ms","start":"2026-03-31T22:23:01.138299Z","end":"2026-03-31T22:23:01.276077Z","steps":["trace[427377543] 'read index received'  (duration: 3.832381ms)","trace[427377543] 'applied index is now lower than readState.Index'  (duration: 133.943363ms)"],"step_count":2}
{"level":"info","ts":"2026-03-31T22:23:01.276421Z","caller":"traceutil/trace.go:171","msg":"trace[741198741] transaction","detail":"{read_only:false; response_revision:1835; number_of_response:1; }","duration":"208.009292ms","start":"2026-03-31T22:23:01.068382Z","end":"2026-03-31T22:23:01.276391Z","steps":["trace[741198741] 'process raft request'  (duration: 73.936256ms)","trace[741198741] 'compare'  (duration: 132.622211ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-31T22:23:01.276424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.109541ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"info","ts":"2026-03-31T22:23:01.276686Z","caller":"traceutil/trace.go:171","msg":"trace[872225738] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1835; }","duration":"138.440558ms","start":"2026-03-31T22:23:01.13823Z","end":"2026-03-31T22:23:01.27667Z","steps":["trace[872225738] 'agreement among raft nodes before linearized reading'  (duration: 137.984418ms)"],"step_count":1}
{"level":"info","ts":"2026-03-31T22:23:09.793281Z","caller":"traceutil/trace.go:171","msg":"trace[1836512070] transaction","detail":"{read_only:false; response_revision:1912; number_of_response:1; }","duration":"102.044664ms","start":"2026-03-31T22:23:09.691195Z","end":"2026-03-31T22:23:09.79324Z","steps":["trace[1836512070] 'process raft request'  (duration: 101.859179ms)"],"step_count":1}
{"level":"info","ts":"2026-03-31T22:23:13.506059Z","caller":"traceutil/trace.go:171","msg":"trace[743758578] linearizableReadLoop","detail":"{readStateIndex:2009; appliedIndex:2008; }","duration":"174.144478ms","start":"2026-03-31T22:23:13.331883Z","end":"2026-03-31T22:23:13.506027Z","steps":["trace[743758578] 'read index received'  (duration: 166.007985ms)","trace[743758578] 'applied index is now lower than readState.Index'  (duration: 8.134813ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-31T22:23:13.506364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.442856ms","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-03-31T22:23:13.506467Z","caller":"traceutil/trace.go:171","msg":"trace[75326083] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1935; }","duration":"174.578859ms","start":"2026-03-31T22:23:13.331866Z","end":"2026-03-31T22:23:13.506445Z","steps":["trace[75326083] 'agreement among raft nodes before linearized reading'  (duration: 174.267581ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-31T22:23:13.506518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.287028ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:554"}
{"level":"warn","ts":"2026-03-31T22:23:13.506506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.638642ms","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-03-31T22:23:13.506575Z","caller":"traceutil/trace.go:171","msg":"trace[1789842695] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1935; }","duration":"112.39627ms","start":"2026-03-31T22:23:13.394165Z","end":"2026-03-31T22:23:13.506561Z","steps":["trace[1789842695] 'agreement among raft nodes before linearized reading'  (duration: 112.182295ms)"],"step_count":1}
{"level":"info","ts":"2026-03-31T22:23:13.506619Z","caller":"traceutil/trace.go:171","msg":"trace[565020693] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1935; }","duration":"164.831017ms","start":"2026-03-31T22:23:13.341762Z","end":"2026-03-31T22:23:13.506593Z","steps":["trace[565020693] 'agreement among raft nodes before linearized reading'  (duration: 164.488309ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-31T22:23:13.506638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.384795ms","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-03-31T22:23:13.506791Z","caller":"traceutil/trace.go:171","msg":"trace[1038285944] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1935; }","duration":"108.680852ms","start":"2026-03-31T22:23:13.398088Z","end":"2026-03-31T22:23:13.506769Z","steps":["trace[1038285944] 'agreement among raft nodes before linearized reading'  (duration: 108.217571ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-31T22:23:47.503145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.335424ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5750706698106833513 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:2122 > 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\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-31T22:23:47.503275Z","caller":"traceutil/trace.go:171","msg":"trace[973060626] transaction","detail":"{read_only:false; response_revision:2131; number_of_response:1; }","duration":"394.91593ms","start":"2026-03-31T22:23:47.108335Z","end":"2026-03-31T22:23:47.503251Z","steps":["trace[973060626] 'process raft request'  (duration: 201.358892ms)","trace[973060626] 'compare'  (duration: 193.077437ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-31T22:23:47.50335Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T22:23:47.108308Z","time spent":"395.009572ms","remote":"127.0.0.1:51372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:2122 > 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":"info","ts":"2026-03-31T22:23:47.571888Z","caller":"traceutil/trace.go:171","msg":"trace[1673121696] linearizableReadLoop","detail":"{readStateIndex:2212; appliedIndex:2210; }","duration":"403.93607ms","start":"2026-03-31T22:23:47.167928Z","end":"2026-03-31T22:23:47.571864Z","steps":["trace[1673121696] 'read index received'  (duration: 141.772453ms)","trace[1673121696] 'applied index is now lower than readState.Index'  (duration: 262.162457ms)"],"step_count":2}
{"level":"info","ts":"2026-03-31T22:23:47.572073Z","caller":"traceutil/trace.go:171","msg":"trace[524851366] transaction","detail":"{read_only:false; response_revision:2132; number_of_response:1; }","duration":"404.439782ms","start":"2026-03-31T22:23:47.167581Z","end":"2026-03-31T22:23:47.572021Z","steps":["trace[524851366] 'process raft request'  (duration: 404.137455ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-31T22:23:47.572186Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"404.240537ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"}
{"level":"info","ts":"2026-03-31T22:23:47.57226Z","caller":"traceutil/trace.go:171","msg":"trace[1807385671] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2132; }","duration":"404.34643ms","start":"2026-03-31T22:23:47.167895Z","end":"2026-03-31T22:23:47.572241Z","steps":["trace[1807385671] 'agreement among raft nodes before linearized reading'  (duration: 404.090684ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-31T22:23:47.572288Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T22:23:47.167558Z","time spent":"404.619297ms","remote":"127.0.0.1:51372","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:2123 > 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":"warn","ts":"2026-03-31T22:23:47.572313Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T22:23:47.167883Z","time spent":"404.415731ms","remote":"127.0.0.1:55346","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5467,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "}
{"level":"info","ts":"2026-03-31T22:23:47.734544Z","caller":"traceutil/trace.go:171","msg":"trace[1602790972] linearizableReadLoop","detail":"{readStateIndex:2213; appliedIndex:2212; }","duration":"162.574832ms","start":"2026-03-31T22:23:47.571945Z","end":"2026-03-31T22:23:47.73452Z","steps":["trace[1602790972] 'read index received'  (duration: 138.349834ms)","trace[1602790972] 'applied index is now lower than readState.Index'  (duration: 24.224018ms)"],"step_count":2}
{"level":"info","ts":"2026-03-31T22:23:47.73471Z","caller":"traceutil/trace.go:171","msg":"trace[1157444639] transaction","detail":"{read_only:false; response_revision:2133; number_of_response:1; }","duration":"349.145387ms","start":"2026-03-31T22:23:47.385529Z","end":"2026-03-31T22:23:47.734674Z","steps":["trace[1157444639] 'process raft request'  (duration: 324.855697ms)","trace[1157444639] 'compare'  (duration: 23.918071ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-31T22:23:47.734779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"530.510298ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-31T22:23:47.734818Z","caller":"traceutil/trace.go:171","msg":"trace[287981757] range","detail":"{range_begin:/registry/deployments/; range_end:/registry/deployments0; response_count:0; response_revision:2133; }","duration":"530.595001ms","start":"2026-03-31T22:23:47.204213Z","end":"2026-03-31T22:23:47.734808Z","steps":["trace[287981757] 'agreement among raft nodes before linearized reading'  (duration: 530.473938ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-31T22:23:47.734862Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T22:23:47.385496Z","time spent":"349.283ms","remote":"127.0.0.1:51372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" mod_revision:2096 > success:<request_put:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" value_size:416 >> failure:<request_range:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" > >"}
{"level":"warn","ts":"2026-03-31T22:23:47.734864Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T22:23:47.204198Z","time spent":"530.656042ms","remote":"127.0.0.1:51550","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":11,"response size":30,"request content":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true "}
{"level":"info","ts":"2026-03-31T22:24:33.817508Z","caller":"traceutil/trace.go:171","msg":"trace[1957189309] transaction","detail":"{read_only:false; response_revision:2491; number_of_response:1; }","duration":"121.732119ms","start":"2026-03-31T22:24:33.69567Z","end":"2026-03-31T22:24:33.817402Z","steps":["trace[1957189309] 'process raft request'  (duration: 121.510974ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-31T22:25:14.349779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.234007ms","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-03-31T22:25:14.349893Z","caller":"traceutil/trace.go:171","msg":"trace[1136101811] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2795; }","duration":"146.416292ms","start":"2026-03-31T22:25:14.203458Z","end":"2026-03-31T22:25:14.349875Z","steps":["trace[1136101811] 'range keys from in-memory index tree'  (duration: 145.90956ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-31T22:25:14.349883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.844688ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:553"}
{"level":"info","ts":"2026-03-31T22:25:14.350532Z","caller":"traceutil/trace.go:171","msg":"trace[1673594668] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2795; }","duration":"146.700458ms","start":"2026-03-31T22:25:14.203773Z","end":"2026-03-31T22:25:14.350473Z","steps":["trace[1673594668] 'range keys from in-memory index tree'  (duration: 145.620283ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-31T22:25:14.350167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.262286ms","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-03-31T22:25:14.350752Z","caller":"traceutil/trace.go:171","msg":"trace[754053159] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2795; }","duration":"148.888699ms","start":"2026-03-31T22:25:14.201846Z","end":"2026-03-31T22:25:14.350735Z","steps":["trace[754053159] 'range keys from in-memory index tree'  (duration: 147.558239ms)"],"step_count":1}
{"level":"info","ts":"2026-03-31T22:25:14.350205Z","caller":"traceutil/trace.go:171","msg":"trace[1030249330] transaction","detail":"{read_only:false; response_revision:2796; number_of_response:1; }","duration":"106.273415ms","start":"2026-03-31T22:25:14.243896Z","end":"2026-03-31T22:25:14.35017Z","steps":["trace[1030249330] 'process raft request'  (duration: 70.517282ms)","trace[1030249330] 'compare'  (duration: 35.581619ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-31T22:25:14.35023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.237687ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-03-31T22:25:14.351041Z","caller":"traceutil/trace.go:171","msg":"trace[439443102] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2795; }","duration":"147.116988ms","start":"2026-03-31T22:25:14.203859Z","end":"2026-03-31T22:25:14.350976Z","steps":["trace[439443102] 'range keys from in-memory index tree'  (duration: 145.765506ms)"],"step_count":1}
{"level":"info","ts":"2026-03-31T22:25:14.764583Z","caller":"traceutil/trace.go:171","msg":"trace[1147705709] transaction","detail":"{read_only:false; response_revision:2801; number_of_response:1; }","duration":"340.544859ms","start":"2026-03-31T22:25:14.424004Z","end":"2026-03-31T22:25:14.764548Z","steps":["trace[1147705709] 'process raft request'  (duration: 292.376514ms)","trace[1147705709] 'compare'  (duration: 47.9385ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-31T22:25:14.764992Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T22:25:14.423975Z","time spent":"340.914457ms","remote":"127.0.0.1:51372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:2745 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"info","ts":"2026-03-31T22:29:01.947551Z","caller":"traceutil/trace.go:171","msg":"trace[705912506] transaction","detail":"{read_only:false; response_revision:4745; number_of_response:1; }","duration":"110.90308ms","start":"2026-03-31T22:29:01.836584Z","end":"2026-03-31T22:29:01.947487Z","steps":["trace[705912506] 'process raft request'  (duration: 27.94476ms)","trace[705912506] 'compare'  (duration: 82.786966ms)"],"step_count":2}
{"level":"info","ts":"2026-03-31T22:29:01.947662Z","caller":"traceutil/trace.go:171","msg":"trace[1701222484] transaction","detail":"{read_only:false; response_revision:4746; number_of_response:1; }","duration":"109.369283ms","start":"2026-03-31T22:29:01.838249Z","end":"2026-03-31T22:29:01.947619Z","steps":["trace[1701222484] 'process raft request'  (duration: 109.186238ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-31T22:29:06.427773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.238575ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5750706698106840270 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:4805 > 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\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-31T22:29:06.428335Z","caller":"traceutil/trace.go:171","msg":"trace[1149809605] transaction","detail":"{read_only:false; response_revision:4916; number_of_response:1; }","duration":"576.143507ms","start":"2026-03-31T22:29:05.852174Z","end":"2026-03-31T22:29:06.428318Z","steps":["trace[1149809605] 'process raft request'  (duration: 457.285357ms)","trace[1149809605] 'compare'  (duration: 117.825486ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-31T22:29:06.428388Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T22:29:05.852161Z","time spent":"576.200688ms","remote":"127.0.0.1:51372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:4805 > 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-03-31T22:29:06.446429Z","caller":"traceutil/trace.go:171","msg":"trace[160207704] linearizableReadLoop","detail":"{readStateIndex:5103; appliedIndex:5101; }","duration":"486.191261ms","start":"2026-03-31T22:29:05.960219Z","end":"2026-03-31T22:29:06.44641Z","steps":["trace[160207704] 'read index received'  (duration: 349.253867ms)","trace[160207704] 'applied index is now lower than readState.Index'  (duration: 136.936364ms)"],"step_count":2}
{"level":"info","ts":"2026-03-31T22:29:06.44653Z","caller":"traceutil/trace.go:171","msg":"trace[125002716] transaction","detail":"{read_only:false; response_revision:4918; number_of_response:1; }","duration":"167.174179ms","start":"2026-03-31T22:29:06.279345Z","end":"2026-03-31T22:29:06.446519Z","steps":["trace[125002716] 'process raft request'  (duration: 167.000135ms)"],"step_count":1}
{"level":"info","ts":"2026-03-31T22:29:06.446605Z","caller":"traceutil/trace.go:171","msg":"trace[378552886] transaction","detail":"{read_only:false; response_revision:4917; number_of_response:1; }","duration":"575.596645ms","start":"2026-03-31T22:29:05.870967Z","end":"2026-03-31T22:29:06.446563Z","steps":["trace[378552886] 'process raft request'  (duration: 575.276538ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-31T22:29:06.446739Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T22:29:05.870946Z","time spent":"575.734348ms","remote":"127.0.0.1:54770","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1687,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/cilium.io/ciliumidentities/1864\" mod_revision:0 > success:<request_put:<key:\"/registry/cilium.io/ciliumidentities/1864\" value_size:1638 >> failure:<>"}
{"level":"warn","ts":"2026-03-31T22:29:06.447092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"486.849926ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"}
{"level":"info","ts":"2026-03-31T22:29:06.447191Z","caller":"traceutil/trace.go:171","msg":"trace[1195620959] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4918; }","duration":"486.957099ms","start":"2026-03-31T22:29:05.960208Z","end":"2026-03-31T22:29:06.447165Z","steps":["trace[1195620959] 'agreement among raft nodes before linearized reading'  (duration: 486.534219ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-31T22:29:06.447245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.701011ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"warn","ts":"2026-03-31T22:29:06.447245Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T22:29:05.960157Z","time spent":"487.074621ms","remote":"127.0.0.1:51372","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":578,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"info","ts":"2026-03-31T22:29:06.447282Z","caller":"traceutil/trace.go:171","msg":"trace[754776812] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4919; }","duration":"335.775113ms","start":"2026-03-31T22:29:06.111498Z","end":"2026-03-31T22:29:06.447273Z","steps":["trace[754776812] 'agreement among raft nodes before linearized reading'  (duration: 335.6589ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-31T22:29:06.447305Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T22:29:06.111487Z","time spent":"335.811624ms","remote":"127.0.0.1:51372","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-03-31T22:29:06.447306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"484.514859ms","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-03-31T22:29:06.447365Z","caller":"traceutil/trace.go:171","msg":"trace[1255122352] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4919; }","duration":"484.583462ms","start":"2026-03-31T22:29:05.962763Z","end":"2026-03-31T22:29:06.447347Z","steps":["trace[1255122352] 'agreement among raft nodes before linearized reading'  (duration: 484.420958ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-31T22:29:06.447403Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T22:29:05.962758Z","time spent":"484.635323ms","remote":"127.0.0.1:51372","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-03-31T22:29:06.44743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"404.835759ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-31T22:29:06.447449Z","caller":"traceutil/trace.go:171","msg":"trace[931169801] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:4919; }","duration":"404.884601ms","start":"2026-03-31T22:29:06.042558Z","end":"2026-03-31T22:29:06.447443Z","steps":["trace[931169801] 'agreement among raft nodes before linearized reading'  (duration: 404.84628ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-31T22:29:06.447473Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T22:29:06.04254Z","time spent":"404.926932ms","remote":"127.0.0.1:51256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":4,"response size":30,"request content":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true "}
{"level":"warn","ts":"2026-03-31T22:29:06.447456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.605823ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-07e5cb64-258f-4804-a7d5-5bec10f56fb4\" ","response":"range_response_count:1 size:3601"}
{"level":"warn","ts":"2026-03-31T22:29:06.447545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"364.649625ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-bjqzw\" ","response":"range_response_count:1 size:9830"}
{"level":"info","ts":"2026-03-31T22:29:06.447597Z","caller":"traceutil/trace.go:171","msg":"trace[1085162709] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-bjqzw; range_end:; response_count:1; response_revision:4919; }","duration":"364.761407ms","start":"2026-03-31T22:29:06.08282Z","end":"2026-03-31T22:29:06.447582Z","steps":["trace[1085162709] 'agreement among raft nodes before linearized reading'  (duration: 364.571563ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-31T22:29:06.447629Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T22:29:06.082801Z","time spent":"364.819499ms","remote":"127.0.0.1:51298","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":1,"response size":9853,"request content":"key:\"/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-bjqzw\" "}
{"level":"info","ts":"2026-03-31T22:29:06.447692Z","caller":"traceutil/trace.go:171","msg":"trace[24557799] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-07e5cb64-258f-4804-a7d5-5bec10f56fb4; range_end:; response_count:1; response_revision:4919; }","duration":"125.880959ms","start":"2026-03-31T22:29:06.321793Z","end":"2026-03-31T22:29:06.447674Z","steps":["trace[24557799] 'agreement among raft nodes before linearized reading'  (duration: 125.474459ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-31T22:29:06.447989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"363.360644ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-bjqzw.18a20d96f0c5e332\" ","response":"range_response_count:1 size:962"}
{"level":"info","ts":"2026-03-31T22:29:06.448057Z","caller":"traceutil/trace.go:171","msg":"trace[1283265317] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-bjqzw.18a20d96f0c5e332; range_end:; response_count:1; response_revision:4919; }","duration":"363.447396ms","start":"2026-03-31T22:29:06.084584Z","end":"2026-03-31T22:29:06.448031Z","steps":["trace[1283265317] 'agreement among raft nodes before linearized reading'  (duration: 362.578125ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-31T22:29:06.448093Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T22:29:06.084569Z","time spent":"363.514668ms","remote":"127.0.0.1:51186","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":1,"response size":985,"request content":"key:\"/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-bjqzw.18a20d96f0c5e332\" "}
{"level":"warn","ts":"2026-03-31T22:29:07.364869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.845078ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-07e5cb64-258f-4804-a7d5-5bec10f56fb4\" ","response":"range_response_count:1 size:3601"}
{"level":"info","ts":"2026-03-31T22:29:07.36496Z","caller":"traceutil/trace.go:171","msg":"trace[1797781020] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-07e5cb64-258f-4804-a7d5-5bec10f56fb4; range_end:; response_count:1; response_revision:4935; }","duration":"268.989731ms","start":"2026-03-31T22:29:07.09595Z","end":"2026-03-31T22:29:07.36494Z","steps":["trace[1797781020] 'range keys from in-memory index tree'  (duration: 268.675432ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-31T22:29:07.365297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.024418ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-bjqzw.18a20d96f0c5e332\" ","response":"range_response_count:1 size:962"}
{"level":"info","ts":"2026-03-31T22:29:07.365333Z","caller":"traceutil/trace.go:171","msg":"trace[400351883] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-bjqzw.18a20d96f0c5e332; range_end:; response_count:1; response_revision:4935; }","duration":"263.09166ms","start":"2026-03-31T22:29:07.102232Z","end":"2026-03-31T22:29:07.365324Z","steps":["trace[400351883] 'range keys from in-memory index tree'  (duration: 262.937926ms)"],"step_count":1}
{"level":"info","ts":"2026-03-31T22:29:09.466747Z","caller":"traceutil/trace.go:171","msg":"trace[2012147845] transaction","detail":"{read_only:false; response_revision:4970; number_of_response:1; }","duration":"220.003096ms","start":"2026-03-31T22:29:09.246731Z","end":"2026-03-31T22:29:09.466734Z","steps":["trace[2012147845] 'process raft request'  (duration: 219.803232ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-31T22:29:09.466978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.83153ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-07e5cb64-258f-4804-a7d5-5bec10f56fb4\" ","response":"range_response_count:1 size:3904"}
{"level":"info","ts":"2026-03-31T22:29:09.467021Z","caller":"traceutil/trace.go:171","msg":"trace[1412623200] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-07e5cb64-258f-4804-a7d5-5bec10f56fb4; range_end:; response_count:1; response_revision:4970; }","duration":"113.928782ms","start":"2026-03-31T22:29:09.353083Z","end":"2026-03-31T22:29:09.467012Z","steps":["trace[1412623200] 'agreement among raft nodes before linearized reading'  (duration: 113.758788ms)"],"step_count":1}
{"level":"info","ts":"2026-03-31T22:29:09.466694Z","caller":"traceutil/trace.go:171","msg":"trace[1816701436] linearizableReadLoop","detail":"{readStateIndex:5158; appliedIndex:5157; }","duration":"113.531763ms","start":"2026-03-31T22:29:09.35314Z","end":"2026-03-31T22:29:09.466672Z","steps":["trace[1816701436] 'read index received'  (duration: 113.371179ms)","trace[1816701436] 'applied index is now lower than readState.Index'  (duration: 159.554µs)"],"step_count":2}
{"level":"info","ts":"2026-03-31T22:29:09.47733Z","caller":"traceutil/trace.go:171","msg":"trace[2050311048] transaction","detail":"{read_only:false; response_revision:4971; number_of_response:1; }","duration":"106.519015ms","start":"2026-03-31T22:29:09.370798Z","end":"2026-03-31T22:29:09.477317Z","steps":["trace[2050311048] 'process raft request'  (duration: 106.253018ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-31T22:29:11.939462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.624523ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5750706698106840510 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/cilium.io/ciliumidentities/16081\" mod_revision:0 > success:<request_put:<key:\"/registry/cilium.io/ciliumidentities/16081\" value_size:2141 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-03-31T22:29:11.939604Z","caller":"traceutil/trace.go:171","msg":"trace[1689844833] linearizableReadLoop","detail":"{readStateIndex:5225; appliedIndex:5224; }","duration":"176.575445ms","start":"2026-03-31T22:29:11.76301Z","end":"2026-03-31T22:29:11.939585Z","steps":["trace[1689844833] 'read index received'  (duration: 30.671304ms)","trace[1689844833] 'applied index is now lower than readState.Index'  (duration: 145.90251ms)"],"step_count":2}
{"level":"info","ts":"2026-03-31T22:29:11.939724Z","caller":"traceutil/trace.go:171","msg":"trace[1147282263] transaction","detail":"{read_only:false; response_revision:5034; number_of_response:1; }","duration":"196.065242ms","start":"2026-03-31T22:29:11.743602Z","end":"2026-03-31T22:29:11.939667Z","steps":["trace[1147282263] 'process raft request'  (duration: 50.166742ms)","trace[1147282263] 'compare'  (duration: 145.433758ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-31T22:29:11.939806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.78662ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:529"}
{"level":"info","ts":"2026-03-31T22:29:11.939842Z","caller":"traceutil/trace.go:171","msg":"trace[1431453917] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:5034; }","duration":"176.867193ms","start":"2026-03-31T22:29:11.762964Z","end":"2026-03-31T22:29:11.939831Z","steps":["trace[1431453917] 'agreement among raft nodes before linearized reading'  (duration: 176.670379ms)"],"step_count":1}
{"level":"info","ts":"2026-03-31T22:29:12.071675Z","caller":"traceutil/trace.go:171","msg":"trace[1280375212] transaction","detail":"{read_only:false; response_revision:5035; number_of_response:1; }","duration":"125.92754ms","start":"2026-03-31T22:29:11.9457Z","end":"2026-03-31T22:29:12.071628Z","steps":["trace[1280375212] 'process raft request'  (duration: 114.083335ms)","trace[1280375212] 'compare'  (duration: 11.506097ms)"],"step_count":2}
{"level":"info","ts":"2026-03-31T22:29:12.071781Z","caller":"traceutil/trace.go:171","msg":"trace[876512962] transaction","detail":"{read_only:false; response_revision:5036; number_of_response:1; }","duration":"122.193281ms","start":"2026-03-31T22:29:11.949542Z","end":"2026-03-31T22:29:12.071736Z","steps":["trace[876512962] 'process raft request'  (duration: 121.883303ms)"],"step_count":1}
{"level":"info","ts":"2026-03-31T22:29:12.279024Z","caller":"traceutil/trace.go:171","msg":"trace[319661915] linearizableReadLoop","detail":"{readStateIndex:5228; appliedIndex:5227; }","duration":"133.502442ms","start":"2026-03-31T22:29:12.145498Z","end":"2026-03-31T22:29:12.279Z","steps":["trace[319661915] 'read index received'  (duration: 131.76048ms)","trace[319661915] 'applied index is now lower than readState.Index'  (duration: 1.740922ms)"],"step_count":2}
{"level":"info","ts":"2026-03-31T22:29:12.279172Z","caller":"traceutil/trace.go:171","msg":"trace[738890242] transaction","detail":"{read_only:false; response_revision:5037; number_of_response:1; }","duration":"165.899279ms","start":"2026-03-31T22:29:12.113225Z","end":"2026-03-31T22:29:12.279125Z","steps":["trace[738890242] 'process raft request'  (duration: 164.079635ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-31T22:29:12.27941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.891691ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:12975"}
{"level":"info","ts":"2026-03-31T22:29:12.279487Z","caller":"traceutil/trace.go:171","msg":"trace[1105424332] range","detail":"{range_begin:/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:5037; }","duration":"134.009054ms","start":"2026-03-31T22:29:12.145454Z","end":"2026-03-31T22:29:12.279463Z","steps":["trace[1105424332] 'agreement among raft nodes before linearized reading'  (duration: 133.661565ms)"],"step_count":1}
{"level":"info","ts":"2026-03-31T22:29:18.688911Z","caller":"traceutil/trace.go:171","msg":"trace[470524358] linearizableReadLoop","detail":"{readStateIndex:5360; appliedIndex:5359; }","duration":"104.197189ms","start":"2026-03-31T22:29:18.584693Z","end":"2026-03-31T22:29:18.68889Z","steps":["trace[470524358] 'read index received'  (duration: 103.899582ms)","trace[470524358] 'applied index is now lower than readState.Index'  (duration: 296.917µs)"],"step_count":2}
{"level":"info","ts":"2026-03-31T22:29:18.689018Z","caller":"traceutil/trace.go:171","msg":"trace[1505875031] transaction","detail":"{read_only:false; response_revision:5165; number_of_response:1; }","duration":"107.57207ms","start":"2026-03-31T22:29:18.581381Z","end":"2026-03-31T22:29:18.688953Z","steps":["trace[1505875031] 'process raft request'  (duration: 107.298734ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-31T22:29:18.689336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.604448ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:8 size:70683"}
{"level":"info","ts":"2026-03-31T22:29:18.689467Z","caller":"traceutil/trace.go:171","msg":"trace[104436053] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:8; response_revision:5165; }","duration":"104.748952ms","start":"2026-03-31T22:29:18.584688Z","end":"2026-03-31T22:29:18.689437Z","steps":["trace[104436053] 'agreement among raft nodes before linearized reading'  (duration: 104.288551ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-31T22:29:27.925575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.775326ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5750706698106841161 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:5233 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-31T22:29:27.925689Z","caller":"traceutil/trace.go:171","msg":"trace[1883814110] linearizableReadLoop","detail":"{readStateIndex:5521; appliedIndex:5520; }","duration":"265.569039ms","start":"2026-03-31T22:29:27.660099Z","end":"2026-03-31T22:29:27.925669Z","steps":["trace[1883814110] 'read index received'  (duration: 84.530937ms)","trace[1883814110] 'applied index is now lower than readState.Index'  (duration: 181.036882ms)"],"step_count":2}
{"level":"info","ts":"2026-03-31T22:29:27.925807Z","caller":"traceutil/trace.go:171","msg":"trace[2013916321] transaction","detail":"{read_only:false; response_revision:5324; number_of_response:1; }","duration":"304.543264ms","start":"2026-03-31T22:29:27.621221Z","end":"2026-03-31T22:29:27.925765Z","steps":["trace[2013916321] 'process raft request'  (duration: 123.488032ms)","trace[2013916321] 'compare'  (duration: 180.407177ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-31T22:29:27.925864Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T22:29:27.621201Z","time spent":"304.632286ms","remote":"127.0.0.1:51372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:5233 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-03-31T22:29:27.926001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.316446ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/shovels/\" range_end:\"/registry/rabbitmq.com/shovels0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-31T22:29:27.926061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.971879ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"}
{"level":"warn","ts":"2026-03-31T22:29:27.926098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.499904ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.123\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-03-31T22:29:27.926163Z","caller":"traceutil/trace.go:171","msg":"trace[1779650547] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5324; }","duration":"266.119272ms","start":"2026-03-31T22:29:27.660023Z","end":"2026-03-31T22:29:27.926142Z","steps":["trace[1779650547] 'agreement among raft nodes before linearized reading'  (duration: 265.862276ms)"],"step_count":1}
{"level":"info","ts":"2026-03-31T22:29:27.926195Z","caller":"traceutil/trace.go:171","msg":"trace[669619741] range","detail":"{range_begin:/registry/masterleases/199.19.213.123; range_end:; response_count:1; response_revision:5324; }","duration":"169.667649ms","start":"2026-03-31T22:29:27.756507Z","end":"2026-03-31T22:29:27.926174Z","steps":["trace[669619741] 'agreement among raft nodes before linearized reading'  (duration: 169.395922ms)"],"step_count":1}
{"level":"info","ts":"2026-03-31T22:29:27.926091Z","caller":"traceutil/trace.go:171","msg":"trace[1974880300] range","detail":"{range_begin:/registry/rabbitmq.com/shovels/; range_end:/registry/rabbitmq.com/shovels0; response_count:0; response_revision:5324; }","duration":"125.449578ms","start":"2026-03-31T22:29:27.80062Z","end":"2026-03-31T22:29:27.926069Z","steps":["trace[1974880300] 'agreement among raft nodes before linearized reading'  (duration: 125.304895ms)"],"step_count":1}
{"level":"info","ts":"2026-03-31T22:29:28.655941Z","caller":"traceutil/trace.go:171","msg":"trace[1131895276] linearizableReadLoop","detail":"{readStateIndex:5526; appliedIndex:5525; }","duration":"297.753252ms","start":"2026-03-31T22:29:28.35816Z","end":"2026-03-31T22:29:28.655913Z","steps":["trace[1131895276] 'read index received'  (duration: 297.66419ms)","trace[1131895276] 'applied index is now lower than readState.Index'  (duration: 87.672µs)"],"step_count":2}
{"level":"info","ts":"2026-03-31T22:29:28.656002Z","caller":"traceutil/trace.go:171","msg":"trace[1958918423] transaction","detail":"{read_only:false; response_revision:5328; number_of_response:1; }","duration":"320.673921ms","start":"2026-03-31T22:29:28.335282Z","end":"2026-03-31T22:29:28.655956Z","steps":["trace[1958918423] 'process raft request'  (duration: 320.435955ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-31T22:29:28.656199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.020079ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3243"}
{"level":"info","ts":"2026-03-31T22:29:28.656241Z","caller":"traceutil/trace.go:171","msg":"trace[465937224] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:5328; }","duration":"298.134631ms","start":"2026-03-31T22:29:28.358093Z","end":"2026-03-31T22:29:28.656228Z","steps":["trace[465937224] 'agreement among raft nodes before linearized reading'  (duration: 297.956657ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-31T22:29:28.656375Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T22:29:28.335256Z","time spent":"320.832135ms","remote":"127.0.0.1:51298","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3751,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-6960db72-d530-400a-a950-f3b9bc71a889\" mod_revision:5294 > success:<request_put:<key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-6960db72-d530-400a-a950-f3b9bc71a889\" value_size:3651 >> failure:<request_range:<key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-6960db72-d530-400a-a950-f3b9bc71a889\" > >"}
{"level":"warn","ts":"2026-03-31T22:29:28.668859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.375547ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-31T22:29:28.668937Z","caller":"traceutil/trace.go:171","msg":"trace[57975589] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:5329; }","duration":"145.51603ms","start":"2026-03-31T22:29:28.523404Z","end":"2026-03-31T22:29:28.66892Z","steps":["trace[57975589] 'agreement among raft nodes before linearized reading'  (duration: 145.399367ms)"],"step_count":1}
{"level":"info","ts":"2026-03-31T22:29:28.668943Z","caller":"traceutil/trace.go:171","msg":"trace[1407419841] transaction","detail":"{read_only:false; response_revision:5329; number_of_response:1; }","duration":"129.761792ms","start":"2026-03-31T22:29:28.539149Z","end":"2026-03-31T22:29:28.668911Z","steps":["trace[1407419841] 'process raft request'  (duration: 129.27165ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-31T22:29:28.6691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.163188ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-6960db72-d530-400a-a950-f3b9bc71a889\" ","response":"range_response_count:1 size:3766"}
{"level":"info","ts":"2026-03-31T22:29:28.669165Z","caller":"traceutil/trace.go:171","msg":"trace[818884250] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-6960db72-d530-400a-a950-f3b9bc71a889; range_end:; response_count:1; response_revision:5329; }","duration":"310.293482ms","start":"2026-03-31T22:29:28.358857Z","end":"2026-03-31T22:29:28.669151Z","steps":["trace[818884250] 'agreement among raft nodes before linearized reading'  (duration: 310.171469ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-31T22:29:28.669216Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T22:29:28.358826Z","time spent":"310.376503ms","remote":"127.0.0.1:51298","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3789,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-6960db72-d530-400a-a950-f3b9bc71a889\" "}
{"level":"info","ts":"2026-03-31T22:29:30.687953Z","caller":"traceutil/trace.go:171","msg":"trace[565030796] transaction","detail":"{read_only:false; response_revision:5376; number_of_response:1; }","duration":"295.933518ms","start":"2026-03-31T22:29:30.391988Z","end":"2026-03-31T22:29:30.687922Z","steps":["trace[565030796] 'process raft request'  (duration: 291.718408ms)"],"step_count":1}
{"level":"info","ts":"2026-03-31T22:29:30.688032Z","caller":"traceutil/trace.go:171","msg":"trace[1573197475] linearizableReadLoop","detail":"{readStateIndex:5577; appliedIndex:5576; }","duration":"290.992799ms","start":"2026-03-31T22:29:30.397018Z","end":"2026-03-31T22:29:30.688011Z","steps":["trace[1573197475] 'read index received'  (duration: 286.716697ms)","trace[1573197475] 'applied index is now lower than readState.Index'  (duration: 4.273422ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-31T22:29:30.688239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.206324ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated\" ","response":"range_response_count:1 size:1131"}
{"level":"info","ts":"2026-03-31T22:29:30.688327Z","caller":"traceutil/trace.go:171","msg":"trace[2063415367] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated; range_end:; response_count:1; response_revision:5376; }","duration":"291.316187ms","start":"2026-03-31T22:29:30.39699Z","end":"2026-03-31T22:29:30.688306Z","steps":["trace[2063415367] 'agreement among raft nodes before linearized reading'  (duration: 291.105192ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-31T22:29:30.688455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.960048ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:4867"}
{"level":"info","ts":"2026-03-31T22:29:30.688538Z","caller":"traceutil/trace.go:171","msg":"trace[1721023175] range","detail":"{range_begin:/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:5377; }","duration":"291.065921ms","start":"2026-03-31T22:29:30.397456Z","end":"2026-03-31T22:29:30.688522Z","steps":["trace[1721023175] 'agreement among raft nodes before linearized reading'  (duration: 290.848996ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-31T22:29:30.688714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.012314ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-31T22:29:30.688785Z","caller":"traceutil/trace.go:171","msg":"trace[1812505387] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5377; }","duration":"179.123506ms","start":"2026-03-31T22:29:30.509646Z","end":"2026-03-31T22:29:30.68877Z","steps":["trace[1812505387] 'agreement among raft nodes before linearized reading'  (duration: 179.026764ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-31T22:29:30.689523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.174712ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:57 size:2210989"}
{"level":"info","ts":"2026-03-31T22:29:30.689574Z","caller":"traceutil/trace.go:171","msg":"trace[56046371] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:57; response_revision:5377; }","duration":"200.228923ms","start":"2026-03-31T22:29:30.489334Z","end":"2026-03-31T22:29:30.689562Z","steps":["trace[56046371] 'agreement among raft nodes before linearized reading'  (duration: 199.399993ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-31T22:29:39.72507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.062376ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5750706698106841579 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:5338 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-31T22:29:39.725335Z","caller":"traceutil/trace.go:171","msg":"trace[1542617176] transaction","detail":"{read_only:false; response_revision:5508; number_of_response:1; }","duration":"130.5283ms","start":"2026-03-31T22:29:39.594782Z","end":"2026-03-31T22:29:39.72531Z","steps":["trace[1542617176] 'process raft request'  (duration: 21.049675ms)","trace[1542617176] 'compare'  (duration: 108.957003ms)"],"step_count":2}
{"level":"info","ts":"2026-03-31T22:30:44.439196Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2961}
{"level":"info","ts":"2026-03-31T22:30:44.511233Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2961,"took":"70.153162ms","hash":2038352919,"current-db-size-bytes":58392576,"current-db-size":"58 MB","current-db-size-in-use-bytes":33845248,"current-db-size-in-use":"34 MB"}
{"level":"info","ts":"2026-03-31T22:30:44.511642Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2038352919,"revision":2961,"compact-revision":-1}
{"level":"info","ts":"2026-03-31T22:32:51.700955Z","caller":"traceutil/trace.go:171","msg":"trace[819822226] linearizableReadLoop","detail":"{readStateIndex:7100; appliedIndex:7099; }","duration":"191.888197ms","start":"2026-03-31T22:32:51.509033Z","end":"2026-03-31T22:32:51.700921Z","steps":["trace[819822226] 'read index received'  (duration: 191.62307ms)","trace[819822226] 'applied index is now lower than readState.Index'  (duration: 260.496µs)"],"step_count":2}
{"level":"info","ts":"2026-03-31T22:32:51.701016Z","caller":"traceutil/trace.go:171","msg":"trace[1015528342] transaction","detail":"{read_only:false; response_revision:6851; number_of_response:1; }","duration":"198.747801ms","start":"2026-03-31T22:32:51.502242Z","end":"2026-03-31T22:32:51.70099Z","steps":["trace[1015528342] 'process raft request'  (duration: 198.512316ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-31T22:32:51.701113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.066ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-31T22:32:51.701161Z","caller":"traceutil/trace.go:171","msg":"trace[1090658349] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:6851; }","duration":"192.162373ms","start":"2026-03-31T22:32:51.508983Z","end":"2026-03-31T22:32:51.701146Z","steps":["trace[1090658349] 'agreement among raft nodes before linearized reading'  (duration: 192.072771ms)"],"step_count":1}
{"level":"info","ts":"2026-03-31T22:35:28.018137Z","caller":"traceutil/trace.go:171","msg":"trace[1133622888] linearizableReadLoop","detail":"{readStateIndex:8446; appliedIndex:8445; }","duration":"237.741265ms","start":"2026-03-31T22:35:27.780356Z","end":"2026-03-31T22:35:28.018097Z","steps":["trace[1133622888] 'read index received'  (duration: 237.51172ms)","trace[1133622888] 'applied index is now lower than readState.Index'  (duration: 228.065µs)"],"step_count":2}
{"level":"warn","ts":"2026-03-31T22:35:28.018484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.965865ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"}
{"level":"warn","ts":"2026-03-31T22:35:28.018487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.090033ms","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-03-31T22:35:28.018534Z","caller":"traceutil/trace.go:171","msg":"trace[1465336678] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8159; }","duration":"156.102098ms","start":"2026-03-31T22:35:27.86242Z","end":"2026-03-31T22:35:28.018522Z","steps":["trace[1465336678] 'agreement among raft nodes before linearized reading'  (duration: 155.882403ms)"],"step_count":1}
{"level":"info","ts":"2026-03-31T22:35:28.018551Z","caller":"traceutil/trace.go:171","msg":"trace[1937592921] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8159; }","duration":"238.192285ms","start":"2026-03-31T22:35:27.780344Z","end":"2026-03-31T22:35:28.018536Z","steps":["trace[1937592921] 'agreement among raft nodes before linearized reading'  (duration: 237.878308ms)"],"step_count":1}
{"level":"info","ts":"2026-03-31T22:35:28.220234Z","caller":"traceutil/trace.go:171","msg":"trace[150317429] transaction","detail":"{read_only:false; response_revision:8160; number_of_response:1; }","duration":"200.819884ms","start":"2026-03-31T22:35:28.019383Z","end":"2026-03-31T22:35:28.220203Z","steps":["trace[150317429] 'process raft request'  (duration: 198.131181ms)"],"step_count":1}
{"level":"info","ts":"2026-03-31T22:35:28.23683Z","caller":"traceutil/trace.go:171","msg":"trace[1142905680] transaction","detail":"{read_only:false; response_revision:8162; number_of_response:1; }","duration":"213.696161ms","start":"2026-03-31T22:35:28.023101Z","end":"2026-03-31T22:35:28.236797Z","steps":["trace[1142905680] 'process raft request'  (duration: 213.577508ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-31T22:35:28.236892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.084443ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-31T22:35:28.23696Z","caller":"traceutil/trace.go:171","msg":"trace[10012035] transaction","detail":"{read_only:false; response_revision:8161; number_of_response:1; }","duration":"213.926597ms","start":"2026-03-31T22:35:28.023018Z","end":"2026-03-31T22:35:28.236944Z","steps":["trace[10012035] 'process raft request'  (duration: 213.468726ms)"],"step_count":1}
{"level":"info","ts":"2026-03-31T22:35:28.236982Z","caller":"traceutil/trace.go:171","msg":"trace[2019748614] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:8162; }","duration":"100.244677ms","start":"2026-03-31T22:35:28.136713Z","end":"2026-03-31T22:35:28.236957Z","steps":["trace[2019748614] 'agreement among raft nodes before linearized reading'  (duration: 100.065673ms)"],"step_count":1}
{"level":"info","ts":"2026-03-31T22:35:41.457666Z","caller":"traceutil/trace.go:171","msg":"trace[1343209656] transaction","detail":"{read_only:false; response_revision:8231; number_of_response:1; }","duration":"338.220538ms","start":"2026-03-31T22:35:41.119391Z","end":"2026-03-31T22:35:41.457612Z","steps":["trace[1343209656] 'process raft request'  (duration: 300.805246ms)","trace[1343209656] 'compare'  (duration: 37.123535ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-31T22:35:41.457949Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T22:35:41.119368Z","time spent":"338.422803ms","remote":"127.0.0.1:51372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":539,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:8219 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:463 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"info","ts":"2026-03-31T22:35:41.496847Z","caller":"traceutil/trace.go:171","msg":"trace[481663974] transaction","detail":"{read_only:false; response_revision:8232; number_of_response:1; }","duration":"317.502935ms","start":"2026-03-31T22:35:41.179321Z","end":"2026-03-31T22:35:41.496824Z","steps":["trace[481663974] 'process raft request'  (duration: 317.362362ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-31T22:35:41.497009Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T22:35:41.179287Z","time spent":"317.638588ms","remote":"127.0.0.1:51372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:8220 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-03-31T22:35:42.494849Z","caller":"traceutil/trace.go:171","msg":"trace[1597354809] transaction","detail":"{read_only:false; response_revision:8236; number_of_response:1; }","duration":"106.599519ms","start":"2026-03-31T22:35:42.388224Z","end":"2026-03-31T22:35:42.494823Z","steps":["trace[1597354809] 'process raft request'  (duration: 12.23468ms)","trace[1597354809] 'compare'  (duration: 94.270387ms)"],"step_count":2}
{"level":"info","ts":"2026-03-31T22:35:42.508727Z","caller":"traceutil/trace.go:171","msg":"trace[1402708655] transaction","detail":"{read_only:false; response_revision:8237; number_of_response:1; }","duration":"120.341597ms","start":"2026-03-31T22:35:42.388364Z","end":"2026-03-31T22:35:42.508705Z","steps":["trace[1402708655] 'process raft request'  (duration: 119.879526ms)"],"step_count":1}
{"level":"info","ts":"2026-03-31T22:35:42.781654Z","caller":"traceutil/trace.go:171","msg":"trace[1252849088] transaction","detail":"{read_only:false; response_revision:8238; number_of_response:1; }","duration":"131.930503ms","start":"2026-03-31T22:35:42.649651Z","end":"2026-03-31T22:35:42.781581Z","steps":["trace[1252849088] 'process raft request'  (duration: 131.574194ms)"],"step_count":1}
{"level":"info","ts":"2026-03-31T22:35:44.445073Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6051}
{"level":"info","ts":"2026-03-31T22:35:44.54811Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6051,"took":"100.962465ms","hash":2643188834,"current-db-size-bytes":58392576,"current-db-size":"58 MB","current-db-size-in-use-bytes":23601152,"current-db-size-in-use":"24 MB"}
{"level":"info","ts":"2026-03-31T22:35:44.548191Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2643188834,"revision":6051,"compact-revision":2961}
{"level":"info","ts":"2026-03-31T22:36:03.725825Z","caller":"traceutil/trace.go:171","msg":"trace[977302102] transaction","detail":"{read_only:false; response_revision:8361; number_of_response:1; }","duration":"115.964604ms","start":"2026-03-31T22:36:03.60983Z","end":"2026-03-31T22:36:03.725795Z","steps":["trace[977302102] 'process raft request'  (duration: 88.083879ms)","trace[977302102] 'compare'  (duration: 27.744182ms)"],"step_count":2}
{"level":"info","ts":"2026-03-31T22:36:07.075163Z","caller":"traceutil/trace.go:171","msg":"trace[510912212] linearizableReadLoop","detail":"{readStateIndex:8720; appliedIndex:8719; }","duration":"117.689674ms","start":"2026-03-31T22:36:06.95745Z","end":"2026-03-31T22:36:07.07514Z","steps":["trace[510912212] 'read index received'  (duration: 113.27918ms)","trace[510912212] 'applied index is now lower than readState.Index'  (duration: 4.409584ms)"],"step_count":2}
{"level":"info","ts":"2026-03-31T22:36:07.075283Z","caller":"traceutil/trace.go:171","msg":"trace[730803595] transaction","detail":"{read_only:false; response_revision:8422; number_of_response:1; }","duration":"166.009345ms","start":"2026-03-31T22:36:06.909263Z","end":"2026-03-31T22:36:07.075272Z","steps":["trace[730803595] 'process raft request'  (duration: 161.545109ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-31T22:36:07.075711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.254378ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/rook-ceph/rook-ceph-csi-config\" ","response":"range_response_count:1 size:512"}
{"level":"info","ts":"2026-03-31T22:36:07.075758Z","caller":"traceutil/trace.go:171","msg":"trace[326167058] range","detail":"{range_begin:/registry/configmaps/rook-ceph/rook-ceph-csi-config; range_end:; response_count:1; response_revision:8422; }","duration":"118.34794ms","start":"2026-03-31T22:36:06.957396Z","end":"2026-03-31T22:36:07.075744Z","steps":["trace[326167058] 'agreement among raft nodes before linearized reading'  (duration: 118.221547ms)"],"step_count":1}
{"level":"info","ts":"2026-03-31T22:36:08.634206Z","caller":"traceutil/trace.go:171","msg":"trace[364187863] transaction","detail":"{read_only:false; response_revision:8432; number_of_response:1; }","duration":"100.375581ms","start":"2026-03-31T22:36:08.533804Z","end":"2026-03-31T22:36:08.634179Z","steps":["trace[364187863] 'process raft request'  (duration: 96.573811ms)"],"step_count":1}
{"level":"info","ts":"2026-03-31T22:36:09.82628Z","caller":"traceutil/trace.go:171","msg":"trace[920363830] transaction","detail":"{read_only:false; response_revision:8438; number_of_response:1; }","duration":"203.540889ms","start":"2026-03-31T22:36:09.622693Z","end":"2026-03-31T22:36:09.826234Z","steps":["trace[920363830] 'process raft request'  (duration: 203.089758ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-31T22:36:10.179603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.049561ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5750706698106849568 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:8427 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:463 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-31T22:36:10.179715Z","caller":"traceutil/trace.go:171","msg":"trace[1841099702] transaction","detail":"{read_only:false; response_revision:8439; number_of_response:1; }","duration":"347.55861ms","start":"2026-03-31T22:36:09.832136Z","end":"2026-03-31T22:36:10.179695Z","steps":["trace[1841099702] 'process raft request'  (duration: 44.275434ms)","trace[1841099702] 'compare'  (duration: 302.757903ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-31T22:36:10.179793Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T22:36:09.832111Z","time spent":"347.651162ms","remote":"127.0.0.1:51372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":539,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:8427 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:463 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-03-31T22:36:12.681645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.884841ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-31T22:36:12.68203Z","caller":"traceutil/trace.go:171","msg":"trace[1304415605] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8451; }","duration":"171.287121ms","start":"2026-03-31T22:36:12.510717Z","end":"2026-03-31T22:36:12.682004Z","steps":["trace[1304415605] 'range keys from in-memory index tree'  (duration: 170.756549ms)"],"step_count":1}
{"level":"info","ts":"2026-03-31T22:36:12.717399Z","caller":"traceutil/trace.go:171","msg":"trace[1822140924] linearizableReadLoop","detail":"{readStateIndex:8751; appliedIndex:8750; }","duration":"193.947102ms","start":"2026-03-31T22:36:12.523432Z","end":"2026-03-31T22:36:12.717379Z","steps":["trace[1822140924] 'read index received'  (duration: 193.702175ms)","trace[1822140924] 'applied index is now lower than readState.Index'  (duration: 243.957µs)"],"step_count":2}
{"level":"info","ts":"2026-03-31T22:36:12.71773Z","caller":"traceutil/trace.go:171","msg":"trace[101005165] transaction","detail":"{read_only:false; response_revision:8452; number_of_response:1; }","duration":"200.707233ms","start":"2026-03-31T22:36:12.517006Z","end":"2026-03-31T22:36:12.717714Z","steps":["trace[101005165] 'process raft request'  (duration: 200.19161ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-31T22:36:12.718054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.609477ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:529"}
{"level":"info","ts":"2026-03-31T22:36:12.7181Z","caller":"traceutil/trace.go:171","msg":"trace[1151464066] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:8452; }","duration":"194.688349ms","start":"2026-03-31T22:36:12.523402Z","end":"2026-03-31T22:36:12.718091Z","steps":["trace[1151464066] 'agreement among raft nodes before linearized reading'  (duration: 194.555116ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-31T22:36:12.718178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.200151ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-31T22:36:12.718373Z","caller":"traceutil/trace.go:171","msg":"trace[250788891] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:8452; }","duration":"182.441027ms","start":"2026-03-31T22:36:12.535909Z","end":"2026-03-31T22:36:12.71835Z","steps":["trace[250788891] 'agreement among raft nodes before linearized reading'  (duration: 182.16257ms)"],"step_count":1}
{"level":"info","ts":"2026-03-31T22:36:12.882685Z","caller":"traceutil/trace.go:171","msg":"trace[902077684] transaction","detail":"{read_only:false; response_revision:8454; number_of_response:1; }","duration":"159.90296ms","start":"2026-03-31T22:36:12.722751Z","end":"2026-03-31T22:36:12.882654Z","steps":["trace[902077684] 'process raft request'  (duration: 112.831779ms)","trace[902077684] 'compare'  (duration: 46.782754ms)"],"step_count":2}
{"level":"info","ts":"2026-03-31T22:36:12.882747Z","caller":"traceutil/trace.go:171","msg":"trace[683062895] transaction","detail":"{read_only:false; response_revision:8455; number_of_response:1; }","duration":"159.326946ms","start":"2026-03-31T22:36:12.7234Z","end":"2026-03-31T22:36:12.882727Z","steps":["trace[683062895] 'process raft request'  (duration: 159.09149ms)"],"step_count":1}
{"level":"info","ts":"2026-03-31T22:36:23.249667Z","caller":"traceutil/trace.go:171","msg":"trace[1585793319] transaction","detail":"{read_only:false; number_of_response:1; response_revision:8551; }","duration":"152.541844ms","start":"2026-03-31T22:36:23.097099Z","end":"2026-03-31T22:36:23.249641Z","steps":["trace[1585793319] 'process raft request'  (duration: 141.504032ms)"],"step_count":1}
{"level":"info","ts":"2026-03-31T22:36:23.260834Z","caller":"traceutil/trace.go:171","msg":"trace[1594873049] transaction","detail":"{read_only:false; response_revision:8552; number_of_response:1; }","duration":"161.626472ms","start":"2026-03-31T22:36:23.099186Z","end":"2026-03-31T22:36:23.260813Z","steps":["trace[1594873049] 'process raft request'  (duration: 161.450187ms)"],"step_count":1}
{"level":"info","ts":"2026-03-31T22:36:23.271317Z","caller":"traceutil/trace.go:171","msg":"trace[329080231] linearizableReadLoop","detail":"{readStateIndex:8856; appliedIndex:8854; }","duration":"100.372321ms","start":"2026-03-31T22:36:23.170909Z","end":"2026-03-31T22:36:23.271281Z","steps":["trace[329080231] 'read index received'  (duration: 67.743704ms)","trace[329080231] 'applied index is now lower than readState.Index'  (duration: 32.626427ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-31T22:36:23.271588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.670399ms","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-03-31T22:36:23.271637Z","caller":"traceutil/trace.go:171","msg":"trace[1701292465] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8552; }","duration":"100.775182ms","start":"2026-03-31T22:36:23.170849Z","end":"2026-03-31T22:36:23.271624Z","steps":["trace[1701292465] 'agreement among raft nodes before linearized reading'  (duration: 100.584057ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-31T22:36:23.27168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.222218ms","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-03-31T22:36:23.271737Z","caller":"traceutil/trace.go:171","msg":"trace[1282561261] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8552; }","duration":"100.349651ms","start":"2026-03-31T22:36:23.171371Z","end":"2026-03-31T22:36:23.271721Z","steps":["trace[1282561261] 'agreement among raft nodes before linearized reading'  (duration: 100.112425ms)"],"step_count":1}
{"level":"info","ts":"2026-03-31T22:36:24.0848Z","caller":"traceutil/trace.go:171","msg":"trace[1494022865] linearizableReadLoop","detail":"{readStateIndex:8863; appliedIndex:8861; }","duration":"114.796135ms","start":"2026-03-31T22:36:23.96998Z","end":"2026-03-31T22:36:24.084776Z","steps":["trace[1494022865] 'read index received'  (duration: 114.432847ms)","trace[1494022865] 'applied index is now lower than readState.Index'  (duration: 362.358µs)"],"step_count":2}
{"level":"warn","ts":"2026-03-31T22:36:24.085023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.028501ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclusters/openstack/ceph\" ","response":"range_response_count:1 size:5732"}
{"level":"info","ts":"2026-03-31T22:36:24.085073Z","caller":"traceutil/trace.go:171","msg":"trace[1848716793] range","detail":"{range_begin:/registry/ceph.rook.io/cephclusters/openstack/ceph; range_end:; response_count:1; response_revision:8558; }","duration":"115.162544ms","start":"2026-03-31T22:36:23.969897Z","end":"2026-03-31T22:36:24.085059Z","steps":["trace[1848716793] 'agreement among raft nodes before linearized reading'  (duration: 114.98696ms)"],"step_count":1}
{"level":"info","ts":"2026-03-31T22:36:24.085055Z","caller":"traceutil/trace.go:171","msg":"trace[401586854] transaction","detail":"{read_only:false; response_revision:8557; number_of_response:1; }","duration":"180.312185ms","start":"2026-03-31T22:36:23.904677Z","end":"2026-03-31T22:36:24.084989Z","steps":["trace[401586854] 'process raft request'  (duration: 179.797123ms)"],"step_count":1}
{"level":"info","ts":"2026-03-31T22:36:24.085289Z","caller":"traceutil/trace.go:171","msg":"trace[15420014] transaction","detail":"{read_only:false; response_revision:8558; number_of_response:1; }","duration":"169.915078ms","start":"2026-03-31T22:36:23.915263Z","end":"2026-03-31T22:36:24.085178Z","steps":["trace[15420014] 'process raft request'  (duration: 169.406346ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-31T22:36:25.240929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.780804ms","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-03-31T22:36:25.24104Z","caller":"traceutil/trace.go:171","msg":"trace[1922205582] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8564; }","duration":"302.946057ms","start":"2026-03-31T22:36:24.938067Z","end":"2026-03-31T22:36:25.241014Z","steps":["trace[1922205582] 'range keys from in-memory index tree'  (duration: 302.566269ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-31T22:36:25.241133Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T22:36:24.938045Z","time spent":"303.07025ms","remote":"127.0.0.1:51372","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-03-31T22:36:25.356036Z","caller":"traceutil/trace.go:171","msg":"trace[1804534768] linearizableReadLoop","detail":"{readStateIndex:8870; appliedIndex:8869; }","duration":"414.175918ms","start":"2026-03-31T22:36:24.941823Z","end":"2026-03-31T22:36:25.355998Z","steps":["trace[1804534768] 'read index received'  (duration: 413.920712ms)","trace[1804534768] 'applied index is now lower than readState.Index'  (duration: 253.926µs)"],"step_count":2}
{"level":"info","ts":"2026-03-31T22:36:25.356142Z","caller":"traceutil/trace.go:171","msg":"trace[17897608] transaction","detail":"{read_only:false; response_revision:8565; number_of_response:1; }","duration":"414.731021ms","start":"2026-03-31T22:36:24.941373Z","end":"2026-03-31T22:36:25.356104Z","steps":["trace[17897608] 'process raft request'  (duration: 414.414153ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-31T22:36:25.356393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T22:36:24.941345Z","time spent":"414.869204ms","remote":"127.0.0.1:51372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:8542 > 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-03-31T22:36:25.356542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"414.635229ms","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-03-31T22:36:25.356656Z","caller":"traceutil/trace.go:171","msg":"trace[1830790957] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8565; }","duration":"414.856884ms","start":"2026-03-31T22:36:24.94178Z","end":"2026-03-31T22:36:25.356637Z","steps":["trace[1830790957] 'agreement among raft nodes before linearized reading'  (duration: 414.402044ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-31T22:36:25.356816Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T22:36:24.94176Z","time spent":"415.012538ms","remote":"127.0.0.1:51372","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-03-31T22:36:25.407512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.16197ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-56xtn\" ","response":"range_response_count:1 size:6531"}
{"level":"info","ts":"2026-03-31T22:36:25.407688Z","caller":"traceutil/trace.go:171","msg":"trace[1515123383] range","detail":"{range_begin:/registry/pods/openstack/keepalived-56xtn; range_end:; response_count:1; response_revision:8566; }","duration":"117.393487ms","start":"2026-03-31T22:36:25.290271Z","end":"2026-03-31T22:36:25.407665Z","steps":["trace[1515123383] 'agreement among raft nodes before linearized reading'  (duration: 117.063288ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-31T22:36:25.407758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.834531ms","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-03-31T22:36:25.407851Z","caller":"traceutil/trace.go:171","msg":"trace[836246732] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8566; }","duration":"110.995515ms","start":"2026-03-31T22:36:25.296836Z","end":"2026-03-31T22:36:25.407831Z","steps":["trace[836246732] 'agreement among raft nodes before linearized reading'  (duration: 110.663776ms)"],"step_count":1}
{"level":"info","ts":"2026-03-31T22:36:25.407714Z","caller":"traceutil/trace.go:171","msg":"trace[448140914] transaction","detail":"{read_only:false; response_revision:8566; number_of_response:1; }","duration":"162.609215ms","start":"2026-03-31T22:36:25.245062Z","end":"2026-03-31T22:36:25.407671Z","steps":["trace[448140914] 'process raft request'  (duration: 162.074291ms)"],"step_count":1}
{"level":"info","ts":"2026-03-31T22:37:10.645185Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002449.wal"}
{"level":"info","ts":"2026-03-31T22:37:25.742558Z","caller":"traceutil/trace.go:171","msg":"trace[1571586501] transaction","detail":"{read_only:false; response_revision:9219; number_of_response:1; }","duration":"167.542843ms","start":"2026-03-31T22:37:25.574934Z","end":"2026-03-31T22:37:25.742476Z","steps":["trace[1571586501] 'process raft request'  (duration: 167.136833ms)"],"step_count":1}
{"level":"info","ts":"2026-03-31T22:37:37.951614Z","caller":"traceutil/trace.go:171","msg":"trace[1708215358] transaction","detail":"{read_only:false; response_revision:9291; number_of_response:1; }","duration":"139.806542ms","start":"2026-03-31T22:37:37.811778Z","end":"2026-03-31T22:37:37.951585Z","steps":["trace[1708215358] 'process raft request'  (duration: 139.555486ms)"],"step_count":1}
{"level":"info","ts":"2026-03-31T22:37:37.976447Z","caller":"traceutil/trace.go:171","msg":"trace[273144232] linearizableReadLoop","detail":"{readStateIndex:9617; appliedIndex:9615; }","duration":"113.980357ms","start":"2026-03-31T22:37:37.862444Z","end":"2026-03-31T22:37:37.976424Z","steps":["trace[273144232] 'read index received'  (duration: 88.932069ms)","trace[273144232] 'applied index is now lower than readState.Index'  (duration: 25.047128ms)"],"step_count":2}
{"level":"info","ts":"2026-03-31T22:37:37.976564Z","caller":"traceutil/trace.go:171","msg":"trace[1492441249] transaction","detail":"{read_only:false; response_revision:9292; number_of_response:1; }","duration":"163.573898ms","start":"2026-03-31T22:37:37.812975Z","end":"2026-03-31T22:37:37.976549Z","steps":["trace[1492441249] 'process raft request'  (duration: 163.321273ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-31T22:37:37.977291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.439307ms","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-03-31T22:37:37.977409Z","caller":"traceutil/trace.go:171","msg":"trace[323325883] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:9292; }","duration":"114.999292ms","start":"2026-03-31T22:37:37.862384Z","end":"2026-03-31T22:37:37.977383Z","steps":["trace[323325883] 'agreement among raft nodes before linearized reading'  (duration: 114.382497ms)"],"step_count":1}
{"level":"info","ts":"2026-03-31T22:37:38.566131Z","caller":"traceutil/trace.go:171","msg":"trace[312817680] linearizableReadLoop","detail":"{readStateIndex:9621; appliedIndex:9620; }","duration":"165.216167ms","start":"2026-03-31T22:37:38.400875Z","end":"2026-03-31T22:37:38.566091Z","steps":["trace[312817680] 'read index received'  (duration: 137.019525ms)","trace[312817680] 'applied index is now lower than readState.Index'  (duration: 28.194772ms)"],"step_count":2}
{"level":"info","ts":"2026-03-31T22:37:38.56631Z","caller":"traceutil/trace.go:171","msg":"trace[2044386803] transaction","detail":"{read_only:false; response_revision:9296; number_of_response:1; }","duration":"351.283843ms","start":"2026-03-31T22:37:38.215004Z","end":"2026-03-31T22:37:38.566288Z","steps":["trace[2044386803] 'process raft request'  (duration: 322.852515ms)","trace[2044386803] 'compare'  (duration: 27.667469ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-31T22:37:38.566678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.760531ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-31T22:37:38.566736Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T22:37:38.214965Z","time spent":"351.394765ms","remote":"127.0.0.1:51372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:9286 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-03-31T22:37:38.566768Z","caller":"traceutil/trace.go:171","msg":"trace[1732896499] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:9296; }","duration":"165.909143ms","start":"2026-03-31T22:37:38.400833Z","end":"2026-03-31T22:37:38.566742Z","steps":["trace[1732896499] 'agreement among raft nodes before linearized reading'  (duration: 165.76117ms)"],"step_count":1}
{"level":"info","ts":"2026-03-31T22:38:29.307816Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"3e4829a3cabe4fce","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-03-31T22:38:29.318391Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-03-31T22:38:29.318523Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-03-31T22:39:52.456791Z","caller":"traceutil/trace.go:171","msg":"trace[1631077199] linearizableReadLoop","detail":"{readStateIndex:10673; appliedIndex:10672; }","duration":"100.330082ms","start":"2026-03-31T22:39:52.35643Z","end":"2026-03-31T22:39:52.45676Z","steps":["trace[1631077199] 'read index received'  (duration: 100.069926ms)","trace[1631077199] 'applied index is now lower than readState.Index'  (duration: 258.976µs)"],"step_count":2}
{"level":"info","ts":"2026-03-31T22:39:52.456862Z","caller":"traceutil/trace.go:171","msg":"trace[544472254] transaction","detail":"{read_only:false; response_revision:10316; number_of_response:1; }","duration":"153.097819ms","start":"2026-03-31T22:39:52.303733Z","end":"2026-03-31T22:39:52.456831Z","steps":["trace[544472254] 'process raft request'  (duration: 152.866033ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-31T22:39:52.457553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.104101ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-barbican-server-0\" ","response":"range_response_count:1 size:1865"}
{"level":"info","ts":"2026-03-31T22:39:52.457634Z","caller":"traceutil/trace.go:171","msg":"trace[286330789] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-barbican-server-0; range_end:; response_count:1; response_revision:10316; }","duration":"101.226354ms","start":"2026-03-31T22:39:52.356383Z","end":"2026-03-31T22:39:52.457609Z","steps":["trace[286330789] 'agreement among raft nodes before linearized reading'  (duration: 100.545047ms)"],"step_count":1}
{"level":"info","ts":"2026-03-31T22:39:56.503759Z","caller":"traceutil/trace.go:171","msg":"trace[983605291] transaction","detail":"{read_only:false; response_revision:10339; number_of_response:1; }","duration":"108.503706ms","start":"2026-03-31T22:39:56.395235Z","end":"2026-03-31T22:39:56.503738Z","steps":["trace[983605291] 'process raft request'  (duration: 108.362363ms)"],"step_count":1}
{"level":"info","ts":"2026-03-31T22:40:44.452413Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8255}
{"level":"info","ts":"2026-03-31T22:40:44.535618Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8255,"took":"81.049262ms","hash":539458401,"current-db-size-bytes":58392576,"current-db-size":"58 MB","current-db-size-in-use-bytes":24788992,"current-db-size-in-use":"25 MB"}
{"level":"info","ts":"2026-03-31T22:40:44.535693Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":539458401,"revision":8255,"compact-revision":6051}
{"level":"info","ts":"2026-03-31T22:45:44.461727Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10648}
{"level":"info","ts":"2026-03-31T22:45:44.545724Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10648,"took":"81.435377ms","hash":2443369660,"current-db-size-bytes":58392576,"current-db-size":"58 MB","current-db-size-in-use-bytes":20365312,"current-db-size-in-use":"20 MB"}
{"level":"info","ts":"2026-03-31T22:45:44.545786Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2443369660,"revision":10648,"compact-revision":8255}