{"level":"warn","ts":"2026-03-06T21:58:02.014328Z","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-06T21:58:02.014423Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.52:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://162.253.55.52:2380","--initial-cluster=instance=https://162.253.55.52:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.52:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.52: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-06T21:58:02.014505Z","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-06T21:58:02.014514Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.52:2380"]}
{"level":"info","ts":"2026-03-06T21:58:02.014531Z","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-06T21:58:02.015127Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.52:2379"]}
{"level":"info","ts":"2026-03-06T21:58:02.015211Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.52:2380"],"listen-peer-urls":["https://162.253.55.52:2380"],"advertise-client-urls":["https://162.253.55.52:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.52:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.52: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-06T21:58:02.019634Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.205378ms"}
{"level":"info","ts":"2026-03-06T21:58:02.028774Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"b11e7fc5714be64b","cluster-id":"9349e4f32a52a90a"}
{"level":"info","ts":"2026-03-06T21:58:02.028921Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b switched to configuration voters=()"}
{"level":"info","ts":"2026-03-06T21:58:02.028957Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b became follower at term 0"}
{"level":"info","ts":"2026-03-06T21:58:02.028976Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft b11e7fc5714be64b [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-03-06T21:58:02.02899Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b became follower at term 1"}
{"level":"info","ts":"2026-03-06T21:58:02.029046Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b switched to configuration voters=(12762778880000648779)"}
{"level":"warn","ts":"2026-03-06T21:58:02.036493Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-03-06T21:58:02.037849Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-03-06T21:58:02.039031Z","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-06T21:58:02.042242Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"b11e7fc5714be64b","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-03-06T21:58:02.042437Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"b11e7fc5714be64b","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-03-06T21:58:02.042508Z","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-06T21:58:02.042749Z","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-06T21:58:02.04282Z","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-06T21:58:02.045009Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b switched to configuration voters=(12762778880000648779)"}
{"level":"info","ts":"2026-03-06T21:58:02.045179Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"9349e4f32a52a90a","local-member-id":"b11e7fc5714be64b","added-peer-id":"b11e7fc5714be64b","added-peer-peer-urls":["https://162.253.55.52:2380"]}
{"level":"info","ts":"2026-03-06T21:58:02.047439Z","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-06T21:58:02.047523Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.52:2380"}
{"level":"info","ts":"2026-03-06T21:58:02.047607Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.52:2380"}
{"level":"info","ts":"2026-03-06T21:58:02.047689Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"b11e7fc5714be64b","initial-advertise-peer-urls":["https://162.253.55.52:2380"],"listen-peer-urls":["https://162.253.55.52:2380"],"advertise-client-urls":["https://162.253.55.52:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.52:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-03-06T21:58:02.047743Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-03-06T21:58:02.130333Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b is starting a new election at term 1"}
{"level":"info","ts":"2026-03-06T21:58:02.13044Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b became pre-candidate at term 1"}
{"level":"info","ts":"2026-03-06T21:58:02.130503Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b received MsgPreVoteResp from b11e7fc5714be64b at term 1"}
{"level":"info","ts":"2026-03-06T21:58:02.130701Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b became candidate at term 2"}
{"level":"info","ts":"2026-03-06T21:58:02.130715Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b received MsgVoteResp from b11e7fc5714be64b at term 2"}
{"level":"info","ts":"2026-03-06T21:58:02.130734Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b became leader at term 2"}
{"level":"info","ts":"2026-03-06T21:58:02.13075Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: b11e7fc5714be64b elected leader b11e7fc5714be64b at term 2"}
{"level":"info","ts":"2026-03-06T21:58:02.131915Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"b11e7fc5714be64b","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.52:2379]}","request-path":"/0/members/b11e7fc5714be64b/attributes","cluster-id":"9349e4f32a52a90a","publish-timeout":"7s"}
{"level":"info","ts":"2026-03-06T21:58:02.131963Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-06T21:58:02.131998Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-06T21:58:02.132304Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-03-06T21:58:02.132343Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-03-06T21:58:02.132439Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-06T21:58:02.133394Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"9349e4f32a52a90a","local-member-id":"b11e7fc5714be64b","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-06T21:58:02.133602Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-06T21:58:02.133653Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-06T21:58:02.135135Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.52:2379"}
{"level":"info","ts":"2026-03-06T21:58:02.13681Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-03-06T21:58:09.86671Z","caller":"traceutil/trace.go:171","msg":"trace[635213128] transaction","detail":"{read_only:false; response_revision:326; number_of_response:1; }","duration":"111.690861ms","start":"2026-03-06T21:58:09.754984Z","end":"2026-03-06T21:58:09.866675Z","steps":["trace[635213128] 'process raft request'  (duration: 111.570578ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T21:58:10.132344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.234902ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16594529622576213984 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:298 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-06T21:58:10.132535Z","caller":"traceutil/trace.go:171","msg":"trace[400219598] linearizableReadLoop","detail":"{readStateIndex:336; appliedIndex:335; }","duration":"178.472827ms","start":"2026-03-06T21:58:09.954036Z","end":"2026-03-06T21:58:10.132509Z","steps":["trace[400219598] 'read index received'  (duration: 51.12105ms)","trace[400219598] 'applied index is now lower than readState.Index'  (duration: 127.349697ms)"],"step_count":2}
{"level":"info","ts":"2026-03-06T21:58:10.132571Z","caller":"traceutil/trace.go:171","msg":"trace[702896205] transaction","detail":"{read_only:false; response_revision:327; number_of_response:1; }","duration":"223.385532ms","start":"2026-03-06T21:58:09.909158Z","end":"2026-03-06T21:58:10.132544Z","steps":["trace[702896205] 'process raft request'  (duration: 96.069745ms)","trace[702896205] 'compare'  (duration: 126.038558ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-06T21:58:10.132651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.61446ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"}
{"level":"info","ts":"2026-03-06T21:58:10.132701Z","caller":"traceutil/trace.go:171","msg":"trace[382244363] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:327; }","duration":"178.713273ms","start":"2026-03-06T21:58:09.953974Z","end":"2026-03-06T21:58:10.132687Z","steps":["trace[382244363] 'agreement among raft nodes before linearized reading'  (duration: 178.613061ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T21:58:10.332771Z","caller":"traceutil/trace.go:171","msg":"trace[562782741] linearizableReadLoop","detail":"{readStateIndex:338; appliedIndex:337; }","duration":"149.753434ms","start":"2026-03-06T21:58:10.182981Z","end":"2026-03-06T21:58:10.332734Z","steps":["trace[562782741] 'read index received'  (duration: 77.775155ms)","trace[562782741] 'applied index is now lower than readState.Index'  (duration: 71.976769ms)"],"step_count":2}
{"level":"info","ts":"2026-03-06T21:58:10.332868Z","caller":"traceutil/trace.go:171","msg":"trace[1514701910] transaction","detail":"{read_only:false; response_revision:329; number_of_response:1; }","duration":"153.630765ms","start":"2026-03-06T21:58:10.179194Z","end":"2026-03-06T21:58:10.332825Z","steps":["trace[1514701910] 'process raft request'  (duration: 81.595334ms)","trace[1514701910] 'compare'  (duration: 71.795945ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-06T21:58:10.333098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.110472ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"}
{"level":"info","ts":"2026-03-06T21:58:10.333185Z","caller":"traceutil/trace.go:171","msg":"trace[1840742288] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:329; }","duration":"150.229955ms","start":"2026-03-06T21:58:10.182933Z","end":"2026-03-06T21:58:10.333163Z","steps":["trace[1840742288] 'agreement among raft nodes before linearized reading'  (duration: 149.960509ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T21:58:10.333368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.538724ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"info","ts":"2026-03-06T21:58:10.333427Z","caller":"traceutil/trace.go:171","msg":"trace[1156744039] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:329; }","duration":"136.652756ms","start":"2026-03-06T21:58:10.196758Z","end":"2026-03-06T21:58:10.333411Z","steps":["trace[1156744039] 'agreement among raft nodes before linearized reading'  (duration: 136.165775ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T21:58:39.047727Z","caller":"traceutil/trace.go:171","msg":"trace[1149403053] linearizableReadLoop","detail":"{readStateIndex:568; appliedIndex:567; }","duration":"279.116149ms","start":"2026-03-06T21:58:38.768575Z","end":"2026-03-06T21:58:39.047691Z","steps":["trace[1149403053] 'read index received'  (duration: 278.944735ms)","trace[1149403053] 'applied index is now lower than readState.Index'  (duration: 170.214µs)"],"step_count":2}
{"level":"info","ts":"2026-03-06T21:58:39.047867Z","caller":"traceutil/trace.go:171","msg":"trace[1468016599] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"371.369703ms","start":"2026-03-06T21:58:38.676487Z","end":"2026-03-06T21:58:39.047857Z","steps":["trace[1468016599] 'process raft request'  (duration: 371.042155ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T21:58:39.047969Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T21:58:38.676457Z","time spent":"371.438426ms","remote":"127.0.0.1:44404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-8fxgx\" mod_revision:502 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-8fxgx\" value_size:17081 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-8fxgx\" > >"}
{"level":"warn","ts":"2026-03-06T21:58:39.048057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.296785ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/cert-manager/\" range_end:\"/registry/secrets/cert-manager0\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-06T21:58:39.048107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.513168ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-06T21:58:39.048143Z","caller":"traceutil/trace.go:171","msg":"trace[1086179018] range","detail":"{range_begin:/registry/secrets/cert-manager/; range_end:/registry/secrets/cert-manager0; response_count:0; response_revision:553; }","duration":"245.438758ms","start":"2026-03-06T21:58:38.802682Z","end":"2026-03-06T21:58:39.04812Z","steps":["trace[1086179018] 'agreement among raft nodes before linearized reading'  (duration: 245.313115ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T21:58:39.048199Z","caller":"traceutil/trace.go:171","msg":"trace[362427476] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:553; }","duration":"279.657731ms","start":"2026-03-06T21:58:38.768519Z","end":"2026-03-06T21:58:39.048177Z","steps":["trace[362427476] 'agreement among raft nodes before linearized reading'  (duration: 279.503768ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T21:58:40.919902Z","caller":"traceutil/trace.go:171","msg":"trace[1066370331] transaction","detail":"{read_only:false; response_revision:681; number_of_response:1; }","duration":"106.045088ms","start":"2026-03-06T21:58:40.813835Z","end":"2026-03-06T21:58:40.91988Z","steps":["trace[1066370331] 'process raft request'  (duration: 105.798102ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T21:58:58.946969Z","caller":"traceutil/trace.go:171","msg":"trace[339179308] transaction","detail":"{read_only:false; response_revision:928; number_of_response:1; }","duration":"120.886443ms","start":"2026-03-06T21:58:58.826058Z","end":"2026-03-06T21:58:58.946944Z","steps":["trace[339179308] 'process raft request'  (duration: 120.716099ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T21:58:59.276049Z","caller":"traceutil/trace.go:171","msg":"trace[1586486439] transaction","detail":"{read_only:false; response_revision:929; number_of_response:1; }","duration":"144.809639ms","start":"2026-03-06T21:58:59.131214Z","end":"2026-03-06T21:58:59.276024Z","steps":["trace[1586486439] 'process raft request'  (duration: 144.663165ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T21:59:54.980904Z","caller":"traceutil/trace.go:171","msg":"trace[960221110] linearizableReadLoop","detail":"{readStateIndex:1660; appliedIndex:1659; }","duration":"212.008876ms","start":"2026-03-06T21:59:54.768869Z","end":"2026-03-06T21:59:54.980877Z","steps":["trace[960221110] 'read index received'  (duration: 197.065063ms)","trace[960221110] 'applied index is now lower than readState.Index'  (duration: 14.942733ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-06T21:59:54.981084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.202651ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-06T21:59:54.981158Z","caller":"traceutil/trace.go:171","msg":"trace[215527282] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1601; }","duration":"212.298113ms","start":"2026-03-06T21:59:54.768827Z","end":"2026-03-06T21:59:54.981125Z","steps":["trace[215527282] 'agreement among raft nodes before linearized reading'  (duration: 212.199011ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T21:59:54.981169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.528563ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-2f350576-f6ae-4394-b5cb-2262bc25d800\" ","response":"range_response_count:1 size:3626"}
{"level":"info","ts":"2026-03-06T21:59:54.981215Z","caller":"traceutil/trace.go:171","msg":"trace[1598198115] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-2f350576-f6ae-4394-b5cb-2262bc25d800; range_end:; response_count:1; response_revision:1601; }","duration":"206.615235ms","start":"2026-03-06T21:59:54.774587Z","end":"2026-03-06T21:59:54.981202Z","steps":["trace[1598198115] 'agreement among raft nodes before linearized reading'  (duration: 206.473012ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T21:59:54.981535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.661686ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:530"}
{"level":"info","ts":"2026-03-06T21:59:54.981638Z","caller":"traceutil/trace.go:171","msg":"trace[656498029] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:1601; }","duration":"157.795899ms","start":"2026-03-06T21:59:54.823816Z","end":"2026-03-06T21:59:54.981612Z","steps":["trace[656498029] 'agreement among raft nodes before linearized reading'  (duration: 157.478451ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T21:59:54.980914Z","caller":"traceutil/trace.go:171","msg":"trace[834732328] transaction","detail":"{read_only:false; response_revision:1601; number_of_response:1; }","duration":"225.380511ms","start":"2026-03-06T21:59:54.755504Z","end":"2026-03-06T21:59:54.980885Z","steps":["trace[834732328] 'process raft request'  (duration: 210.528329ms)","trace[834732328] 'compare'  (duration: 14.441942ms)"],"step_count":2}
{"level":"info","ts":"2026-03-06T22:00:09.288393Z","caller":"traceutil/trace.go:171","msg":"trace[816779179] transaction","detail":"{read_only:false; response_revision:1714; number_of_response:1; }","duration":"226.99203ms","start":"2026-03-06T22:00:09.061343Z","end":"2026-03-06T22:00:09.288335Z","steps":["trace[816779179] 'process raft request'  (duration: 213.761068ms)","trace[816779179] 'compare'  (duration: 13.019707ms)"],"step_count":2}
{"level":"info","ts":"2026-03-06T22:00:09.288521Z","caller":"traceutil/trace.go:171","msg":"trace[2133168640] transaction","detail":"{read_only:false; response_revision:1716; number_of_response:1; }","duration":"114.480199ms","start":"2026-03-06T22:00:09.174022Z","end":"2026-03-06T22:00:09.288502Z","steps":["trace[2133168640] 'process raft request'  (duration: 114.315865ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T22:00:09.28854Z","caller":"traceutil/trace.go:171","msg":"trace[1099230070] transaction","detail":"{read_only:false; response_revision:1715; number_of_response:1; }","duration":"140.749676ms","start":"2026-03-06T22:00:09.147742Z","end":"2026-03-06T22:00:09.288491Z","steps":["trace[1099230070] 'process raft request'  (duration: 140.517631ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T22:00:45.486241Z","caller":"traceutil/trace.go:171","msg":"trace[355831258] transaction","detail":"{read_only:false; response_revision:1909; number_of_response:1; }","duration":"108.414631ms","start":"2026-03-06T22:00:45.377798Z","end":"2026-03-06T22:00:45.486213Z","steps":["trace[355831258] 'process raft request'  (duration: 108.259177ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T22:00:45.604096Z","caller":"traceutil/trace.go:171","msg":"trace[407226782] transaction","detail":"{read_only:false; response_revision:1911; number_of_response:1; }","duration":"105.240795ms","start":"2026-03-06T22:00:45.498822Z","end":"2026-03-06T22:00:45.604062Z","steps":["trace[407226782] 'process raft request'  (duration: 60.742835ms)","trace[407226782] 'compare'  (duration: 44.306515ms)"],"step_count":2}
{"level":"info","ts":"2026-03-06T22:00:45.604215Z","caller":"traceutil/trace.go:171","msg":"trace[1177163440] transaction","detail":"{read_only:false; response_revision:1912; number_of_response:1; }","duration":"103.881432ms","start":"2026-03-06T22:00:45.500306Z","end":"2026-03-06T22:00:45.604188Z","steps":["trace[1177163440] 'process raft request'  (duration: 103.709847ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T22:00:45.870654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.231064ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.52\" ","response":"range_response_count:1 size:133"}
{"level":"info","ts":"2026-03-06T22:00:45.870776Z","caller":"traceutil/trace.go:171","msg":"trace[1881889461] range","detail":"{range_begin:/registry/masterleases/162.253.55.52; range_end:; response_count:1; response_revision:1912; }","duration":"140.355877ms","start":"2026-03-06T22:00:45.73039Z","end":"2026-03-06T22:00:45.870745Z","steps":["trace[1881889461] 'range keys from in-memory index tree'  (duration: 140.076991ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T22:00:46.03647Z","caller":"traceutil/trace.go:171","msg":"trace[1019546394] linearizableReadLoop","detail":"{readStateIndex:1984; appliedIndex:1982; }","duration":"150.666838ms","start":"2026-03-06T22:00:45.885782Z","end":"2026-03-06T22:00:46.036448Z","steps":["trace[1019546394] 'read index received'  (duration: 125.176839ms)","trace[1019546394] 'applied index is now lower than readState.Index'  (duration: 25.489189ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-06T22:00:46.036673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.873102ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"}
{"level":"info","ts":"2026-03-06T22:00:46.036712Z","caller":"traceutil/trace.go:171","msg":"trace[749028903] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1913; }","duration":"150.949215ms","start":"2026-03-06T22:00:45.88575Z","end":"2026-03-06T22:00:46.036699Z","steps":["trace[749028903] 'agreement among raft nodes before linearized reading'  (duration: 150.781881ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T22:00:46.036716Z","caller":"traceutil/trace.go:171","msg":"trace[1862458017] transaction","detail":"{read_only:false; response_revision:1913; number_of_response:1; }","duration":"161.217253ms","start":"2026-03-06T22:00:45.875466Z","end":"2026-03-06T22:00:46.036683Z","steps":["trace[1862458017] 'process raft request'  (duration: 160.845704ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T22:01:42.089977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.084602ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"}
{"level":"info","ts":"2026-03-06T22:01:42.090094Z","caller":"traceutil/trace.go:171","msg":"trace[1384253242] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2357; }","duration":"235.250395ms","start":"2026-03-06T22:01:41.854824Z","end":"2026-03-06T22:01:42.090075Z","steps":["trace[1384253242] 'range keys from in-memory index tree'  (duration: 234.867176ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T22:01:42.090064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.527881ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"warn","ts":"2026-03-06T22:01:42.090005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.000741ms","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-06T22:01:42.090164Z","caller":"traceutil/trace.go:171","msg":"trace[135387699] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2357; }","duration":"232.682584ms","start":"2026-03-06T22:01:41.857456Z","end":"2026-03-06T22:01:42.090139Z","steps":["trace[135387699] 'range keys from in-memory index tree'  (duration: 232.213914ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T22:01:42.09021Z","caller":"traceutil/trace.go:171","msg":"trace[950626765] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2357; }","duration":"230.221036ms","start":"2026-03-06T22:01:41.859966Z","end":"2026-03-06T22:01:42.090187Z","steps":["trace[950626765] 'range keys from in-memory index tree'  (duration: 229.781917ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T22:04:40.782975Z","caller":"traceutil/trace.go:171","msg":"trace[818220156] transaction","detail":"{read_only:false; response_revision:3436; number_of_response:1; }","duration":"125.873909ms","start":"2026-03-06T22:04:40.657068Z","end":"2026-03-06T22:04:40.782942Z","steps":["trace[818220156] 'process raft request'  (duration: 125.705815ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T22:06:09.594395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.41728ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16594529622576223711 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/monitoring/vector-5plww.189a5fd46e10745f\" mod_revision:0 > success:<request_put:<key:\"/registry/events/monitoring/vector-5plww.189a5fd46e10745f\" value_size:660 lease:7371157585721446606 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-03-06T22:06:09.594484Z","caller":"traceutil/trace.go:171","msg":"trace[433175299] linearizableReadLoop","detail":"{readStateIndex:4778; appliedIndex:4777; }","duration":"190.453404ms","start":"2026-03-06T22:06:09.404018Z","end":"2026-03-06T22:06:09.594471Z","steps":["trace[433175299] 'read index received'  (duration: 56.876618ms)","trace[433175299] 'applied index is now lower than readState.Index'  (duration: 133.575626ms)"],"step_count":2}
{"level":"info","ts":"2026-03-06T22:06:09.594534Z","caller":"traceutil/trace.go:171","msg":"trace[1891605974] transaction","detail":"{read_only:false; response_revision:4598; number_of_response:1; }","duration":"284.314015ms","start":"2026-03-06T22:06:09.310213Z","end":"2026-03-06T22:06:09.594527Z","steps":["trace[1891605974] 'process raft request'  (duration: 150.655658ms)","trace[1891605974] 'compare'  (duration: 133.268547ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-06T22:06:09.594908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.870234ms","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-06T22:06:09.595001Z","caller":"traceutil/trace.go:171","msg":"trace[2118964590] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4598; }","duration":"191.005726ms","start":"2026-03-06T22:06:09.403976Z","end":"2026-03-06T22:06:09.594981Z","steps":["trace[2118964590] 'agreement among raft nodes before linearized reading'  (duration: 190.700269ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T22:06:09.689857Z","caller":"traceutil/trace.go:171","msg":"trace[1908741494] transaction","detail":"{read_only:false; response_revision:4599; number_of_response:1; }","duration":"173.664839ms","start":"2026-03-06T22:06:09.516148Z","end":"2026-03-06T22:06:09.689813Z","steps":["trace[1908741494] 'process raft request'  (duration: 173.362061ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T22:06:09.689899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.67472ms","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-06T22:06:09.6899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.693724ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-8efd6771-1f8f-4505-9523-d7d4b3364553\" ","response":"range_response_count:1 size:3600"}
{"level":"info","ts":"2026-03-06T22:06:09.689969Z","caller":"traceutil/trace.go:171","msg":"trace[1403379899] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4599; }","duration":"283.824394ms","start":"2026-03-06T22:06:09.406128Z","end":"2026-03-06T22:06:09.689952Z","steps":["trace[1403379899] 'agreement among raft nodes before linearized reading'  (duration: 283.593478ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T22:06:09.689986Z","caller":"traceutil/trace.go:171","msg":"trace[1788448695] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-8efd6771-1f8f-4505-9523-d7d4b3364553; range_end:; response_count:1; response_revision:4599; }","duration":"188.838417ms","start":"2026-03-06T22:06:09.501125Z","end":"2026-03-06T22:06:09.689963Z","steps":["trace[1788448695] 'agreement among raft nodes before linearized reading'  (duration: 188.583221ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T22:06:09.777826Z","caller":"traceutil/trace.go:171","msg":"trace[715074550] transaction","detail":"{read_only:false; response_revision:4600; number_of_response:1; }","duration":"179.080876ms","start":"2026-03-06T22:06:09.598703Z","end":"2026-03-06T22:06:09.777783Z","steps":["trace[715074550] 'process raft request'  (duration: 143.101039ms)","trace[715074550] 'compare'  (duration: 35.768382ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-06T22:06:09.777923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.905297ms","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-06T22:06:09.778Z","caller":"traceutil/trace.go:171","msg":"trace[1866074771] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4601; }","duration":"124.02831ms","start":"2026-03-06T22:06:09.653952Z","end":"2026-03-06T22:06:09.77798Z","steps":["trace[1866074771] 'agreement among raft nodes before linearized reading'  (duration: 123.807225ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T22:06:10.222686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.136818ms","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-06T22:06:10.222784Z","caller":"traceutil/trace.go:171","msg":"trace[114236992] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4603; }","duration":"117.269621ms","start":"2026-03-06T22:06:10.105493Z","end":"2026-03-06T22:06:10.222762Z","steps":["trace[114236992] 'range keys from in-memory index tree'  (duration: 116.986855ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T22:06:17.948106Z","caller":"traceutil/trace.go:171","msg":"trace[205935488] transaction","detail":"{read_only:false; response_revision:4756; number_of_response:1; }","duration":"113.250383ms","start":"2026-03-06T22:06:17.834826Z","end":"2026-03-06T22:06:17.948077Z","steps":["trace[205935488] 'process raft request'  (duration: 110.519999ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T22:06:17.948221Z","caller":"traceutil/trace.go:171","msg":"trace[1597865190] transaction","detail":"{read_only:false; response_revision:4757; number_of_response:1; }","duration":"112.724741ms","start":"2026-03-06T22:06:17.835452Z","end":"2026-03-06T22:06:17.948176Z","steps":["trace[1597865190] 'process raft request'  (duration: 112.523506ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T22:06:17.948422Z","caller":"traceutil/trace.go:171","msg":"trace[864125057] transaction","detail":"{read_only:false; response_revision:4758; number_of_response:1; }","duration":"110.512979ms","start":"2026-03-06T22:06:17.837874Z","end":"2026-03-06T22:06:17.948387Z","steps":["trace[864125057] 'process raft request'  (duration: 110.218512ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T22:06:17.948674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.469348ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/openstack/\" range_end:\"/registry/limitranges/openstack0\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-06T22:06:17.949155Z","caller":"traceutil/trace.go:171","msg":"trace[1262937908] range","detail":"{range_begin:/registry/limitranges/openstack/; range_end:/registry/limitranges/openstack0; response_count:0; response_revision:4759; }","duration":"110.97406ms","start":"2026-03-06T22:06:17.838155Z","end":"2026-03-06T22:06:17.949129Z","steps":["trace[1262937908] 'agreement among raft nodes before linearized reading'  (duration: 110.425207ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T22:06:41.233866Z","caller":"traceutil/trace.go:171","msg":"trace[1287860392] linearizableReadLoop","detail":"{readStateIndex:5316; appliedIndex:5315; }","duration":"238.207852ms","start":"2026-03-06T22:06:40.99563Z","end":"2026-03-06T22:06:41.233837Z","steps":["trace[1287860392] 'read index received'  (duration: 238.042558ms)","trace[1287860392] 'applied index is now lower than readState.Index'  (duration: 164.164µs)"],"step_count":2}
{"level":"info","ts":"2026-03-06T22:06:41.233988Z","caller":"traceutil/trace.go:171","msg":"trace[1168877994] transaction","detail":"{read_only:false; response_revision:5124; number_of_response:1; }","duration":"240.342023ms","start":"2026-03-06T22:06:40.993614Z","end":"2026-03-06T22:06:41.233956Z","steps":["trace[1168877994] 'process raft request'  (duration: 240.063247ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T22:06:41.234224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.565271ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-keystone-server\" ","response":"range_response_count:1 size:9639"}
{"level":"info","ts":"2026-03-06T22:06:41.234319Z","caller":"traceutil/trace.go:171","msg":"trace[1204086518] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-keystone-server; range_end:; response_count:1; response_revision:5124; }","duration":"238.683283ms","start":"2026-03-06T22:06:40.995614Z","end":"2026-03-06T22:06:41.234298Z","steps":["trace[1204086518] 'agreement among raft nodes before linearized reading'  (duration: 238.390816ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T22:06:41.28959Z","caller":"traceutil/trace.go:171","msg":"trace[553453262] transaction","detail":"{read_only:false; response_revision:5125; number_of_response:1; }","duration":"188.750115ms","start":"2026-03-06T22:06:41.100806Z","end":"2026-03-06T22:06:41.289556Z","steps":["trace[553453262] 'process raft request'  (duration: 154.006365ms)","trace[553453262] 'compare'  (duration: 34.338011ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-06T22:06:41.303277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.868842ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-465qw\" ","response":"range_response_count:1 size:6447"}
{"level":"info","ts":"2026-03-06T22:06:41.303349Z","caller":"traceutil/trace.go:171","msg":"trace[1151294056] range","detail":"{range_begin:/registry/pods/openstack/keepalived-465qw; range_end:; response_count:1; response_revision:5125; }","duration":"217.991605ms","start":"2026-03-06T22:06:41.085346Z","end":"2026-03-06T22:06:41.303338Z","steps":["trace[1151294056] 'agreement among raft nodes before linearized reading'  (duration: 217.847701ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T22:06:41.303388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.196235ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:16401"}
{"level":"info","ts":"2026-03-06T22:06:41.303475Z","caller":"traceutil/trace.go:171","msg":"trace[1754897944] range","detail":"{range_begin:/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:5125; }","duration":"111.321377ms","start":"2026-03-06T22:06:41.192123Z","end":"2026-03-06T22:06:41.303445Z","steps":["trace[1754897944] 'agreement among raft nodes before linearized reading'  (duration: 111.078192ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T22:06:41.303479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.579003ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-06T22:06:41.303707Z","caller":"traceutil/trace.go:171","msg":"trace[580726763] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5125; }","duration":"244.8458ms","start":"2026-03-06T22:06:41.058842Z","end":"2026-03-06T22:06:41.303688Z","steps":["trace[580726763] 'agreement among raft nodes before linearized reading'  (duration: 244.608794ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T22:08:02.584247Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2777}
{"level":"info","ts":"2026-03-06T22:08:02.642038Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2777,"took":"55.187546ms","hash":2944141047,"current-db-size-bytes":41033728,"current-db-size":"41 MB","current-db-size-in-use-bytes":31100928,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-03-06T22:08:02.642102Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2944141047,"revision":2777,"compact-revision":-1}
{"level":"info","ts":"2026-03-06T22:12:41.845784Z","caller":"traceutil/trace.go:171","msg":"trace[22134214] linearizableReadLoop","detail":"{readStateIndex:7943; appliedIndex:7942; }","duration":"149.040041ms","start":"2026-03-06T22:12:41.696704Z","end":"2026-03-06T22:12:41.845744Z","steps":["trace[22134214] 'read index received'  (duration: 114.455333ms)","trace[22134214] 'applied index is now lower than readState.Index'  (duration: 34.579378ms)"],"step_count":2}
{"level":"info","ts":"2026-03-06T22:12:41.845801Z","caller":"traceutil/trace.go:171","msg":"trace[1368990384] transaction","detail":"{read_only:false; response_revision:7662; number_of_response:1; }","duration":"232.170695ms","start":"2026-03-06T22:12:41.613594Z","end":"2026-03-06T22:12:41.845765Z","steps":["trace[1368990384] 'process raft request'  (duration: 197.583507ms)","trace[1368990384] 'compare'  (duration: 34.351601ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-06T22:12:41.846036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.322877ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"warn","ts":"2026-03-06T22:12:41.846097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.849719ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:559"}
{"level":"info","ts":"2026-03-06T22:12:41.846125Z","caller":"traceutil/trace.go:171","msg":"trace[2066913099] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:7663; }","duration":"149.45455ms","start":"2026-03-06T22:12:41.696646Z","end":"2026-03-06T22:12:41.846101Z","steps":["trace[2066913099] 'agreement among raft nodes before linearized reading'  (duration: 149.206045ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T22:12:41.84614Z","caller":"traceutil/trace.go:171","msg":"trace[2065886211] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:7663; }","duration":"143.9092ms","start":"2026-03-06T22:12:41.702217Z","end":"2026-03-06T22:12:41.846126Z","steps":["trace[2065886211] 'agreement among raft nodes before linearized reading'  (duration: 143.707165ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T22:13:02.589715Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5770}
{"level":"info","ts":"2026-03-06T22:13:02.673462Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5770,"took":"81.8154ms","hash":3723227059,"current-db-size-bytes":44056576,"current-db-size":"44 MB","current-db-size-in-use-bytes":22892544,"current-db-size-in-use":"23 MB"}
{"level":"info","ts":"2026-03-06T22:13:02.673513Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3723227059,"revision":5770,"compact-revision":2777}
{"level":"warn","ts":"2026-03-06T22:13:11.013564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.992428ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-06T22:13:11.013647Z","caller":"traceutil/trace.go:171","msg":"trace[528546494] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:7859; }","duration":"244.108712ms","start":"2026-03-06T22:13:10.76952Z","end":"2026-03-06T22:13:11.013629Z","steps":["trace[528546494] 'range keys from in-memory index tree'  (duration: 243.924486ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T22:13:11.01365Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T22:13:10.664907Z","time spent":"348.734643ms","remote":"127.0.0.1:43558","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"warn","ts":"2026-03-06T22:13:23.511681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.038171ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16594529622576232699 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/openstack/rook-ceph-detect-version-c2mjj.189a60397cff6728\" mod_revision:0 > success:<request_put:<key:\"/registry/events/openstack/rook-ceph-detect-version-c2mjj.189a60397cff6728\" value_size:654 lease:7371157585721455795 >> failure:<>>","response":"size:16"}
{"level":"warn","ts":"2026-03-06T22:13:23.511663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.279708ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-c2mjj\" ","response":"range_response_count:1 size:4647"}
{"level":"info","ts":"2026-03-06T22:13:23.511814Z","caller":"traceutil/trace.go:171","msg":"trace[2018759176] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-c2mjj; range_end:; response_count:1; response_revision:7961; }","duration":"159.475123ms","start":"2026-03-06T22:13:23.352309Z","end":"2026-03-06T22:13:23.511784Z","steps":["trace[2018759176] 'range keys from in-memory index tree'  (duration: 159.056393ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T22:13:23.512216Z","caller":"traceutil/trace.go:171","msg":"trace[951575613] transaction","detail":"{read_only:false; response_revision:7962; number_of_response:1; }","duration":"159.256928ms","start":"2026-03-06T22:13:23.352938Z","end":"2026-03-06T22:13:23.512195Z","steps":["trace[951575613] 'process raft request'  (duration: 45.627914ms)","trace[951575613] 'compare'  (duration: 112.804085ms)"],"step_count":2}
{"level":"info","ts":"2026-03-06T22:13:23.679987Z","caller":"traceutil/trace.go:171","msg":"trace[467653750] transaction","detail":"{read_only:false; response_revision:7964; number_of_response:1; }","duration":"160.58676ms","start":"2026-03-06T22:13:23.519369Z","end":"2026-03-06T22:13:23.679955Z","steps":["trace[467653750] 'process raft request'  (duration: 148.859552ms)","trace[467653750] 'compare'  (duration: 11.282017ms)"],"step_count":2}
{"level":"info","ts":"2026-03-06T22:14:38.506924Z","caller":"traceutil/trace.go:171","msg":"trace[736387025] transaction","detail":"{read_only:false; response_revision:8668; number_of_response:1; }","duration":"150.089281ms","start":"2026-03-06T22:14:38.356804Z","end":"2026-03-06T22:14:38.506893Z","steps":["trace[736387025] 'process raft request'  (duration: 149.869306ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T22:14:38.582915Z","caller":"traceutil/trace.go:171","msg":"trace[991739773] transaction","detail":"{read_only:false; response_revision:8669; number_of_response:1; }","duration":"213.690849ms","start":"2026-03-06T22:14:38.369196Z","end":"2026-03-06T22:14:38.582887Z","steps":["trace[991739773] 'process raft request'  (duration: 213.519035ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T22:16:57.437486Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"b11e7fc5714be64b","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-03-06T22:16:57.442532Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-03-06T22:16:57.442616Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-03-06T22:18:02.59558Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":7770}
{"level":"info","ts":"2026-03-06T22:18:02.662065Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":7770,"took":"64.131777ms","hash":58124042,"current-db-size-bytes":44056576,"current-db-size":"44 MB","current-db-size-in-use-bytes":27942912,"current-db-size-in-use":"28 MB"}
{"level":"info","ts":"2026-03-06T22:18:02.662145Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":58124042,"revision":7770,"compact-revision":5770}
{"level":"info","ts":"2026-03-06T22:23:02.6013Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10307}
{"level":"info","ts":"2026-03-06T22:23:02.680204Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10307,"took":"76.267435ms","hash":4085649672,"current-db-size-bytes":44056576,"current-db-size":"44 MB","current-db-size-in-use-bytes":24743936,"current-db-size-in-use":"25 MB"}
{"level":"info","ts":"2026-03-06T22:23:02.680272Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4085649672,"revision":10307,"compact-revision":7770}
{"level":"warn","ts":"2026-03-06T22:24:36.068824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.146675ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16594529622576246231 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/masterleases/162.253.55.52\" mod_revision:12691 > success:<request_put:<key:\"/registry/masterleases/162.253.55.52\" value_size:67 lease:7371157585721470421 >> failure:<request_range:<key:\"/registry/masterleases/162.253.55.52\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-06T22:24:36.06891Z","caller":"traceutil/trace.go:171","msg":"trace[1400944717] transaction","detail":"{read_only:false; response_revision:12740; number_of_response:1; }","duration":"250.503112ms","start":"2026-03-06T22:24:35.818394Z","end":"2026-03-06T22:24:36.068897Z","steps":["trace[1400944717] 'process raft request'  (duration: 137.228194ms)","trace[1400944717] 'compare'  (duration: 112.868768ms)"],"step_count":2}
{"level":"info","ts":"2026-03-06T22:24:51.92063Z","caller":"traceutil/trace.go:171","msg":"trace[1841875826] transaction","detail":"{read_only:false; response_revision:12825; number_of_response:1; }","duration":"190.110364ms","start":"2026-03-06T22:24:51.730494Z","end":"2026-03-06T22:24:51.920604Z","steps":["trace[1841875826] 'process raft request'  (duration: 189.946349ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T22:24:51.931924Z","caller":"traceutil/trace.go:171","msg":"trace[1136968627] linearizableReadLoop","detail":"{readStateIndex:13288; appliedIndex:13286; }","duration":"164.317625ms","start":"2026-03-06T22:24:51.767581Z","end":"2026-03-06T22:24:51.931899Z","steps":["trace[1136968627] 'read index received'  (duration: 152.829073ms)","trace[1136968627] 'applied index is now lower than readState.Index'  (duration: 11.487652ms)"],"step_count":2}
{"level":"info","ts":"2026-03-06T22:24:51.931961Z","caller":"traceutil/trace.go:171","msg":"trace[2077297023] transaction","detail":"{read_only:false; response_revision:12826; number_of_response:1; }","duration":"187.246487ms","start":"2026-03-06T22:24:51.744686Z","end":"2026-03-06T22:24:51.931933Z","steps":["trace[2077297023] 'process raft request'  (duration: 187.054912ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T22:24:51.932118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.51183ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-06T22:24:51.932214Z","caller":"traceutil/trace.go:171","msg":"trace[2128007324] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:12826; }","duration":"164.616632ms","start":"2026-03-06T22:24:51.767576Z","end":"2026-03-06T22:24:51.932192Z","steps":["trace[2128007324] 'agreement among raft nodes before linearized reading'  (duration: 164.452528ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T22:24:51.932244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.436678ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-03-06T22:24:51.932306Z","caller":"traceutil/trace.go:171","msg":"trace[469229903] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:12826; }","duration":"123.52421ms","start":"2026-03-06T22:24:51.80875Z","end":"2026-03-06T22:24:51.932274Z","steps":["trace[469229903] 'agreement among raft nodes before linearized reading'  (duration: 123.366076ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T22:24:51.932329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.055035ms","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-06T22:24:51.932373Z","caller":"traceutil/trace.go:171","msg":"trace[1405130024] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:12826; }","duration":"119.147147ms","start":"2026-03-06T22:24:51.813212Z","end":"2026-03-06T22:24:51.932359Z","steps":["trace[1405130024] 'agreement among raft nodes before linearized reading'  (duration: 118.928182ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T22:24:51.932359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.627314ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"warn","ts":"2026-03-06T22:24:51.932392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.165331ms","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-06T22:24:51.932428Z","caller":"traceutil/trace.go:171","msg":"trace[1289273912] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:12826; }","duration":"115.722166ms","start":"2026-03-06T22:24:51.816688Z","end":"2026-03-06T22:24:51.93241Z","steps":["trace[1289273912] 'agreement among raft nodes before linearized reading'  (duration: 115.43859ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T22:24:51.932443Z","caller":"traceutil/trace.go:171","msg":"trace[1561802780] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:12826; }","duration":"120.237323ms","start":"2026-03-06T22:24:51.812187Z","end":"2026-03-06T22:24:51.932424Z","steps":["trace[1561802780] 'agreement among raft nodes before linearized reading'  (duration: 120.032548ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T22:24:52.969686Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000033f0.wal"}
{"level":"info","ts":"2026-03-06T22:25:12.697308Z","caller":"traceutil/trace.go:171","msg":"trace[645288609] linearizableReadLoop","detail":"{readStateIndex:13594; appliedIndex:13593; }","duration":"165.947213ms","start":"2026-03-06T22:25:12.531317Z","end":"2026-03-06T22:25:12.697265Z","steps":["trace[645288609] 'read index received'  (duration: 165.84514ms)","trace[645288609] 'applied index is now lower than readState.Index'  (duration: 100.953µs)"],"step_count":2}
{"level":"info","ts":"2026-03-06T22:25:12.697331Z","caller":"traceutil/trace.go:171","msg":"trace[985961703] transaction","detail":"{read_only:false; response_revision:13121; number_of_response:1; }","duration":"246.960409ms","start":"2026-03-06T22:25:12.450341Z","end":"2026-03-06T22:25:12.697301Z","steps":["trace[985961703] 'process raft request'  (duration: 246.762984ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T22:25:12.697762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.430275ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-0d9c537f-aa7d-405b-8095-e6022335023b\" ","response":"range_response_count:1 size:3636"}
{"level":"info","ts":"2026-03-06T22:25:12.69783Z","caller":"traceutil/trace.go:171","msg":"trace[1551539467] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-0d9c537f-aa7d-405b-8095-e6022335023b; range_end:; response_count:1; response_revision:13121; }","duration":"166.513086ms","start":"2026-03-06T22:25:12.531298Z","end":"2026-03-06T22:25:12.697811Z","steps":["trace[1551539467] 'agreement among raft nodes before linearized reading'  (duration: 166.119357ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T22:25:12.702265Z","caller":"traceutil/trace.go:171","msg":"trace[952861499] transaction","detail":"{read_only:false; response_revision:13122; number_of_response:1; }","duration":"165.481592ms","start":"2026-03-06T22:25:12.53676Z","end":"2026-03-06T22:25:12.702242Z","steps":["trace[952861499] 'process raft request'  (duration: 165.356049ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T22:25:12.70232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.172311ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:19055"}
{"level":"info","ts":"2026-03-06T22:25:12.702373Z","caller":"traceutil/trace.go:171","msg":"trace[1853188720] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:13122; }","duration":"150.224272ms","start":"2026-03-06T22:25:12.552133Z","end":"2026-03-06T22:25:12.702357Z","steps":["trace[1853188720] 'agreement among raft nodes before linearized reading'  (duration: 150.075759ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T22:26:37.708217Z","caller":"traceutil/trace.go:171","msg":"trace[557358236] transaction","detail":"{read_only:false; response_revision:13883; number_of_response:1; }","duration":"177.874805ms","start":"2026-03-06T22:26:37.530306Z","end":"2026-03-06T22:26:37.708181Z","steps":["trace[557358236] 'process raft request'  (duration: 177.619139ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T22:28:02.607771Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12192}
{"level":"info","ts":"2026-03-06T22:28:02.682373Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12192,"took":"72.055103ms","hash":2348121891,"current-db-size-bytes":44056576,"current-db-size":"44 MB","current-db-size-in-use-bytes":27377664,"current-db-size-in-use":"27 MB"}
{"level":"info","ts":"2026-03-06T22:28:02.682425Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2348121891,"revision":12192,"compact-revision":10307}
{"level":"info","ts":"2026-03-06T22:32:12.354666Z","caller":"traceutil/trace.go:171","msg":"trace[652615759] transaction","detail":"{read_only:false; response_revision:16218; number_of_response:1; }","duration":"107.692769ms","start":"2026-03-06T22:32:12.246946Z","end":"2026-03-06T22:32:12.354639Z","steps":["trace[652615759] 'process raft request'  (duration: 90.78252ms)","trace[652615759] 'compare'  (duration: 16.612622ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-06T22:32:18.825342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.534108ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16594529622576259772 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:16248 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:464 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-06T22:32:18.825472Z","caller":"traceutil/trace.go:171","msg":"trace[1767165928] transaction","detail":"{read_only:false; response_revision:16260; number_of_response:1; }","duration":"448.685151ms","start":"2026-03-06T22:32:18.376767Z","end":"2026-03-06T22:32:18.825452Z","steps":["trace[1767165928] 'process raft request'  (duration: 211.947599ms)","trace[1767165928] 'compare'  (duration: 236.382874ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-06T22:32:18.82554Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T22:32:18.376735Z","time spent":"448.772653ms","remote":"127.0.0.1:44482","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:16248 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:464 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"info","ts":"2026-03-06T22:33:02.613743Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14406}
{"level":"info","ts":"2026-03-06T22:33:02.703746Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14406,"took":"87.014832ms","hash":2871822225,"current-db-size-bytes":44056576,"current-db-size":"44 MB","current-db-size-in-use-bytes":29249536,"current-db-size-in-use":"29 MB"}
{"level":"info","ts":"2026-03-06T22:33:02.703815Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2871822225,"revision":14406,"compact-revision":12192}
{"level":"info","ts":"2026-03-06T22:37:51.93584Z","caller":"traceutil/trace.go:171","msg":"trace[1572870566] transaction","detail":"{read_only:false; response_revision:18710; number_of_response:1; }","duration":"106.137252ms","start":"2026-03-06T22:37:51.829677Z","end":"2026-03-06T22:37:51.935814Z","steps":["trace[1572870566] 'process raft request'  (duration: 105.871726ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T22:37:57.82652Z","caller":"traceutil/trace.go:171","msg":"trace[165968524] transaction","detail":"{read_only:false; response_revision:18737; number_of_response:1; }","duration":"231.258141ms","start":"2026-03-06T22:37:57.595221Z","end":"2026-03-06T22:37:57.826479Z","steps":["trace[165968524] 'process raft request'  (duration: 231.026046ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T22:37:58.159876Z","caller":"traceutil/trace.go:171","msg":"trace[1270863849] transaction","detail":"{read_only:false; response_revision:18739; number_of_response:1; }","duration":"173.096369ms","start":"2026-03-06T22:37:57.98674Z","end":"2026-03-06T22:37:58.159836Z","steps":["trace[1270863849] 'process raft request'  (duration: 135.672547ms)","trace[1270863849] 'compare'  (duration: 37.206437ms)"],"step_count":2}
{"level":"info","ts":"2026-03-06T22:37:58.1601Z","caller":"traceutil/trace.go:171","msg":"trace[2122376821] transaction","detail":"{read_only:false; response_revision:18740; number_of_response:1; }","duration":"171.80887ms","start":"2026-03-06T22:37:57.988263Z","end":"2026-03-06T22:37:58.160072Z","steps":["trace[2122376821] 'process raft request'  (duration: 171.510933ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T22:37:58.160056Z","caller":"traceutil/trace.go:171","msg":"trace[1668323773] linearizableReadLoop","detail":"{readStateIndex:19406; appliedIndex:19404; }","duration":"139.677423ms","start":"2026-03-06T22:37:58.020336Z","end":"2026-03-06T22:37:58.160014Z","steps":["trace[1668323773] 'read index received'  (duration: 101.897022ms)","trace[1668323773] 'applied index is now lower than readState.Index'  (duration: 37.77744ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-06T22:37:58.160386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.036761ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"}
{"level":"info","ts":"2026-03-06T22:37:58.160479Z","caller":"traceutil/trace.go:171","msg":"trace[164559609] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:18740; }","duration":"140.215066ms","start":"2026-03-06T22:37:58.020244Z","end":"2026-03-06T22:37:58.160459Z","steps":["trace[164559609] 'agreement among raft nodes before linearized reading'  (duration: 139.909748ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T22:37:58.420995Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.800015ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16594529622576267067 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" mod_revision:18671 > success:<request_put:<key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" value_size:466 >> failure:<request_range:<key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" > >>","response":"size:18"}
{"level":"info","ts":"2026-03-06T22:37:58.421119Z","caller":"traceutil/trace.go:171","msg":"trace[2141738580] linearizableReadLoop","detail":"{readStateIndex:19407; appliedIndex:19406; }","duration":"204.363628ms","start":"2026-03-06T22:37:58.216737Z","end":"2026-03-06T22:37:58.421101Z","steps":["trace[2141738580] 'read index received'  (duration: 67.333927ms)","trace[2141738580] 'applied index is now lower than readState.Index'  (duration: 137.028541ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-06T22:37:58.421182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.45168ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-03-06T22:37:58.421194Z","caller":"traceutil/trace.go:171","msg":"trace[274243833] transaction","detail":"{read_only:false; response_revision:18741; number_of_response:1; }","duration":"221.01562ms","start":"2026-03-06T22:37:58.200134Z","end":"2026-03-06T22:37:58.42115Z","steps":["trace[274243833] 'process raft request'  (duration: 83.968559ms)","trace[274243833] 'compare'  (duration: 136.644602ms)"],"step_count":2}
{"level":"info","ts":"2026-03-06T22:37:58.421209Z","caller":"traceutil/trace.go:171","msg":"trace[877302740] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:18741; }","duration":"204.516851ms","start":"2026-03-06T22:37:58.216683Z","end":"2026-03-06T22:37:58.4212Z","steps":["trace[877302740] 'agreement among raft nodes before linearized reading'  (duration: 204.46396ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T22:37:59.065447Z","caller":"traceutil/trace.go:171","msg":"trace[501893550] linearizableReadLoop","detail":"{readStateIndex:19410; appliedIndex:19409; }","duration":"220.449857ms","start":"2026-03-06T22:37:58.84497Z","end":"2026-03-06T22:37:59.06542Z","steps":["trace[501893550] 'read index received'  (duration: 130.825785ms)","trace[501893550] 'applied index is now lower than readState.Index'  (duration: 89.623112ms)"],"step_count":2}
{"level":"info","ts":"2026-03-06T22:37:59.065502Z","caller":"traceutil/trace.go:171","msg":"trace[1266780387] transaction","detail":"{read_only:false; response_revision:18744; number_of_response:1; }","duration":"292.812433ms","start":"2026-03-06T22:37:58.772659Z","end":"2026-03-06T22:37:59.065471Z","steps":["trace[1266780387] 'process raft request'  (duration: 203.121739ms)","trace[1266780387] 'compare'  (duration: 89.440349ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-06T22:37:59.065608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.616751ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-03-06T22:37:59.065743Z","caller":"traceutil/trace.go:171","msg":"trace[1418193221] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:18744; }","duration":"220.789864ms","start":"2026-03-06T22:37:58.844942Z","end":"2026-03-06T22:37:59.065732Z","steps":["trace[1418193221] 'agreement among raft nodes before linearized reading'  (duration: 220.58967ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T22:38:02.619505Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":16803}
{"level":"info","ts":"2026-03-06T22:38:02.720136Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":16803,"took":"97.59044ms","hash":2037720598,"current-db-size-bytes":45322240,"current-db-size":"45 MB","current-db-size-in-use-bytes":29597696,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-03-06T22:38:02.720208Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2037720598,"revision":16803,"compact-revision":14406}
{"level":"info","ts":"2026-03-06T22:39:01.982505Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"b11e7fc5714be64b","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-03-06T22:39:02.015815Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002}
{"level":"info","ts":"2026-03-06T22:39:02.015942Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002}
{"level":"info","ts":"2026-03-06T22:41:44.378332Z","caller":"traceutil/trace.go:171","msg":"trace[756581020] transaction","detail":"{read_only:false; response_revision:21008; number_of_response:1; }","duration":"149.32194ms","start":"2026-03-06T22:41:44.22898Z","end":"2026-03-06T22:41:44.378302Z","steps":["trace[756581020] 'process raft request'  (duration: 130.148098ms)","trace[756581020] 'compare'  (duration: 19.035438ms)"],"step_count":2}
{"level":"info","ts":"2026-03-06T22:43:02.633156Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":18760}
{"level":"info","ts":"2026-03-06T22:43:02.742622Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":18760,"took":"105.587899ms","hash":2500168370,"current-db-size-bytes":50053120,"current-db-size":"50 MB","current-db-size-in-use-bytes":37662720,"current-db-size-in-use":"38 MB"}
{"level":"info","ts":"2026-03-06T22:43:02.742703Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2500168370,"revision":18760,"compact-revision":16803}
{"level":"warn","ts":"2026-03-06T22:45:20.011922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.917226ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"}
{"level":"info","ts":"2026-03-06T22:45:20.012066Z","caller":"traceutil/trace.go:171","msg":"trace[712634653] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:23085; }","duration":"173.08947ms","start":"2026-03-06T22:45:19.838956Z","end":"2026-03-06T22:45:20.012045Z","steps":["trace[712634653] 'range keys from in-memory index tree'  (duration: 172.790942ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T22:45:20.588713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.892377ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16594529622576278690 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:23075 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >>","response":"size:18"}
{"level":"info","ts":"2026-03-06T22:45:20.5889Z","caller":"traceutil/trace.go:171","msg":"trace[897614365] linearizableReadLoop","detail":"{readStateIndex:23886; appliedIndex:23884; }","duration":"130.995765ms","start":"2026-03-06T22:45:20.457892Z","end":"2026-03-06T22:45:20.588888Z","steps":["trace[897614365] 'read index received'  (duration: 120.922238ms)","trace[897614365] 'applied index is now lower than readState.Index'  (duration: 10.072947ms)"],"step_count":2}
{"level":"info","ts":"2026-03-06T22:45:20.588928Z","caller":"traceutil/trace.go:171","msg":"trace[2115008076] transaction","detail":"{read_only:false; response_revision:23089; number_of_response:1; }","duration":"260.737381ms","start":"2026-03-06T22:45:20.328158Z","end":"2026-03-06T22:45:20.588895Z","steps":["trace[2115008076] 'process raft request'  (duration: 114.574737ms)","trace[2115008076] 'compare'  (duration: 145.423856ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-06T22:45:20.58897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.074387ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates/\" range_end:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-03-06T22:45:20.588993Z","caller":"traceutil/trace.go:171","msg":"trace[56373282] range","detail":"{range_begin:/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates/; range_end:/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates0; response_count:0; response_revision:23090; }","duration":"131.143619ms","start":"2026-03-06T22:45:20.457842Z","end":"2026-03-06T22:45:20.588986Z","steps":["trace[56373282] 'agreement among raft nodes before linearized reading'  (duration: 131.078507ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T22:45:20.588979Z","caller":"traceutil/trace.go:171","msg":"trace[805420873] transaction","detail":"{read_only:false; response_revision:23090; number_of_response:1; }","duration":"178.673022ms","start":"2026-03-06T22:45:20.410273Z","end":"2026-03-06T22:45:20.588946Z","steps":["trace[805420873] 'process raft request'  (duration: 178.534339ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T22:45:20.797406Z","caller":"traceutil/trace.go:171","msg":"trace[418523899] transaction","detail":"{read_only:false; response_revision:23091; number_of_response:1; }","duration":"188.855683ms","start":"2026-03-06T22:45:20.608526Z","end":"2026-03-06T22:45:20.797382Z","steps":["trace[418523899] 'process raft request'  (duration: 169.834234ms)","trace[418523899] 'compare'  (duration: 18.68564ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-06T22:45:24.953422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.277294ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-03-06T22:45:24.953515Z","caller":"traceutil/trace.go:171","msg":"trace[1393850026] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:23117; }","duration":"184.435828ms","start":"2026-03-06T22:45:24.769059Z","end":"2026-03-06T22:45:24.953495Z","steps":["trace[1393850026] 'range keys from in-memory index tree'  (duration: 184.157572ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T22:45:24.965841Z","caller":"traceutil/trace.go:171","msg":"trace[351007593] transaction","detail":"{read_only:false; response_revision:23118; number_of_response:1; }","duration":"157.39505ms","start":"2026-03-06T22:45:24.808415Z","end":"2026-03-06T22:45:24.96581Z","steps":["trace[351007593] 'process raft request'  (duration: 157.198395ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T22:45:25.132837Z","caller":"traceutil/trace.go:171","msg":"trace[2083858560] transaction","detail":"{read_only:false; response_revision:23119; number_of_response:1; }","duration":"102.689916ms","start":"2026-03-06T22:45:25.029948Z","end":"2026-03-06T22:45:25.132638Z","steps":["trace[2083858560] 'process raft request'  (duration: 100.973056ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T22:45:27.752871Z","caller":"traceutil/trace.go:171","msg":"trace[1158063773] linearizableReadLoop","detail":"{readStateIndex:23938; appliedIndex:23936; }","duration":"165.989341ms","start":"2026-03-06T22:45:27.586858Z","end":"2026-03-06T22:45:27.752848Z","steps":["trace[1158063773] 'read index received'  (duration: 113.338988ms)","trace[1158063773] 'applied index is now lower than readState.Index'  (duration: 52.649593ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-06T22:45:27.752993Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.126066ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-03-06T22:45:27.753027Z","caller":"traceutil/trace.go:171","msg":"trace[633115312] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0; response_count:0; response_revision:23140; }","duration":"166.176897ms","start":"2026-03-06T22:45:27.586838Z","end":"2026-03-06T22:45:27.753015Z","steps":["trace[633115312] 'agreement among raft nodes before linearized reading'  (duration: 166.101765ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T22:45:27.75316Z","caller":"traceutil/trace.go:171","msg":"trace[446759251] transaction","detail":"{read_only:false; response_revision:23139; number_of_response:1; }","duration":"295.620836ms","start":"2026-03-06T22:45:27.457506Z","end":"2026-03-06T22:45:27.753126Z","steps":["trace[446759251] 'process raft request'  (duration: 242.703585ms)","trace[446759251] 'compare'  (duration: 52.438969ms)"],"step_count":2}
{"level":"info","ts":"2026-03-06T22:45:27.753265Z","caller":"traceutil/trace.go:171","msg":"trace[162180661] transaction","detail":"{read_only:false; response_revision:23140; number_of_response:1; }","duration":"228.900759ms","start":"2026-03-06T22:45:27.524348Z","end":"2026-03-06T22:45:27.753249Z","steps":["trace[162180661] 'process raft request'  (duration: 228.446997ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T22:45:28.567187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.622951ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-03-06T22:45:28.567276Z","caller":"traceutil/trace.go:171","msg":"trace[365532730] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:23143; }","duration":"178.759864ms","start":"2026-03-06T22:45:28.388497Z","end":"2026-03-06T22:45:28.567257Z","steps":["trace[365532730] 'range keys from in-memory index tree'  (duration: 178.480338ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T22:45:28.890947Z","caller":"traceutil/trace.go:171","msg":"trace[512981029] linearizableReadLoop","detail":"{readStateIndex:23943; appliedIndex:23942; }","duration":"174.551325ms","start":"2026-03-06T22:45:28.716372Z","end":"2026-03-06T22:45:28.890923Z","steps":["trace[512981029] 'read index received'  (duration: 174.475894ms)","trace[512981029] 'applied index is now lower than readState.Index'  (duration: 74.481µs)"],"step_count":2}
{"level":"info","ts":"2026-03-06T22:45:28.890987Z","caller":"traceutil/trace.go:171","msg":"trace[159008359] transaction","detail":"{read_only:false; response_revision:23145; number_of_response:1; }","duration":"212.957341ms","start":"2026-03-06T22:45:28.678002Z","end":"2026-03-06T22:45:28.890959Z","steps":["trace[159008359] 'process raft request'  (duration: 212.770667ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T22:45:28.891303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.918014ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"}
{"level":"info","ts":"2026-03-06T22:45:28.891358Z","caller":"traceutil/trace.go:171","msg":"trace[1712276304] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:23145; }","duration":"175.019636ms","start":"2026-03-06T22:45:28.716321Z","end":"2026-03-06T22:45:28.891341Z","steps":["trace[1712276304] 'agreement among raft nodes before linearized reading'  (duration: 174.728679ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T22:45:28.926786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.06535ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:562"}
{"level":"info","ts":"2026-03-06T22:45:28.926882Z","caller":"traceutil/trace.go:171","msg":"trace[573358128] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:23146; }","duration":"209.172413ms","start":"2026-03-06T22:45:28.717685Z","end":"2026-03-06T22:45:28.926858Z","steps":["trace[573358128] 'agreement among raft nodes before linearized reading'  (duration: 208.929016ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T22:45:28.927009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.597921ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-03-06T22:45:28.927085Z","caller":"traceutil/trace.go:171","msg":"trace[621392180] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:23146; }","duration":"159.713763ms","start":"2026-03-06T22:45:28.767355Z","end":"2026-03-06T22:45:28.927069Z","steps":["trace[621392180] 'agreement among raft nodes before linearized reading'  (duration: 159.601611ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T22:45:28.927019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.380392ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rook-ceph-pdbstatemap\" ","response":"range_response_count:1 size:357"}
{"level":"info","ts":"2026-03-06T22:45:28.927199Z","caller":"traceutil/trace.go:171","msg":"trace[1035815976] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-pdbstatemap; range_end:; response_count:1; response_revision:23146; }","duration":"111.602097ms","start":"2026-03-06T22:45:28.815576Z","end":"2026-03-06T22:45:28.927178Z","steps":["trace[1035815976] 'agreement among raft nodes before linearized reading'  (duration: 111.194457ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T22:45:29.174218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.555031ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16594529622576278835 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:23133 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >>","response":"size:18"}
{"level":"info","ts":"2026-03-06T22:45:29.174289Z","caller":"traceutil/trace.go:171","msg":"trace[12794699] linearizableReadLoop","detail":"{readStateIndex:23945; appliedIndex:23944; }","duration":"246.093486ms","start":"2026-03-06T22:45:28.928184Z","end":"2026-03-06T22:45:29.174278Z","steps":["trace[12794699] 'read index received'  (duration: 141.433732ms)","trace[12794699] 'applied index is now lower than readState.Index'  (duration: 104.658914ms)"],"step_count":2}
{"level":"info","ts":"2026-03-06T22:45:29.174426Z","caller":"traceutil/trace.go:171","msg":"trace[391931312] transaction","detail":"{read_only:false; response_revision:23147; number_of_response:1; }","duration":"279.802792ms","start":"2026-03-06T22:45:28.894616Z","end":"2026-03-06T22:45:29.174418Z","steps":["trace[391931312] 'process raft request'  (duration: 174.987195ms)","trace[391931312] 'compare'  (duration: 104.456328ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-06T22:45:29.174554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.370472ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-03-06T22:45:29.174575Z","caller":"traceutil/trace.go:171","msg":"trace[1039073182] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:23147; }","duration":"246.422072ms","start":"2026-03-06T22:45:28.928148Z","end":"2026-03-06T22:45:29.17457Z","steps":["trace[1039073182] 'agreement among raft nodes before linearized reading'  (duration: 246.387132ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T22:45:29.183429Z","caller":"traceutil/trace.go:171","msg":"trace[857435850] transaction","detail":"{read_only:false; response_revision:23149; number_of_response:1; }","duration":"207.219447ms","start":"2026-03-06T22:45:28.976184Z","end":"2026-03-06T22:45:29.183404Z","steps":["trace[857435850] 'process raft request'  (duration: 207.175896ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T22:45:29.183466Z","caller":"traceutil/trace.go:171","msg":"trace[377310695] transaction","detail":"{read_only:false; response_revision:23148; number_of_response:1; }","duration":"251.574515ms","start":"2026-03-06T22:45:28.931879Z","end":"2026-03-06T22:45:29.183453Z","steps":["trace[377310695] 'process raft request'  (duration: 251.36831ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T22:45:29.342266Z","caller":"traceutil/trace.go:171","msg":"trace[638367300] linearizableReadLoop","detail":"{readStateIndex:23948; appliedIndex:23945; }","duration":"167.945628ms","start":"2026-03-06T22:45:29.174303Z","end":"2026-03-06T22:45:29.342249Z","steps":["trace[638367300] 'read index received'  (duration: 8.939641ms)","trace[638367300] 'applied index is now lower than readState.Index'  (duration: 159.005107ms)"],"step_count":2}
{"level":"info","ts":"2026-03-06T22:45:29.342428Z","caller":"traceutil/trace.go:171","msg":"trace[624581145] transaction","detail":"{read_only:false; response_revision:23150; number_of_response:1; }","duration":"187.872119ms","start":"2026-03-06T22:45:29.154548Z","end":"2026-03-06T22:45:29.34242Z","steps":["trace[624581145] 'process raft request'  (duration: 187.193343ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T22:45:29.342613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.307862ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/vhosts/\" range_end:\"/registry/rabbitmq.com/vhosts0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-03-06T22:45:29.342728Z","caller":"traceutil/trace.go:171","msg":"trace[237104952] range","detail":"{range_begin:/registry/rabbitmq.com/vhosts/; range_end:/registry/rabbitmq.com/vhosts0; response_count:0; response_revision:23150; }","duration":"274.434985ms","start":"2026-03-06T22:45:29.068275Z","end":"2026-03-06T22:45:29.34271Z","steps":["trace[237104952] 'agreement among raft nodes before linearized reading'  (duration: 274.257671ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T22:45:29.470798Z","caller":"traceutil/trace.go:171","msg":"trace[1920727188] transaction","detail":"{read_only:false; response_revision:23151; number_of_response:1; }","duration":"123.943889ms","start":"2026-03-06T22:45:29.346806Z","end":"2026-03-06T22:45:29.47075Z","steps":["trace[1920727188] 'process raft request'  (duration: 120.347494ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T22:45:29.733475Z","caller":"traceutil/trace.go:171","msg":"trace[676292575] transaction","detail":"{read_only:false; response_revision:23152; number_of_response:1; }","duration":"199.117785ms","start":"2026-03-06T22:45:29.534319Z","end":"2026-03-06T22:45:29.733437Z","steps":["trace[676292575] 'process raft request'  (duration: 127.492663ms)","trace[676292575] 'compare'  (duration: 71.188451ms)"],"step_count":2}
{"level":"info","ts":"2026-03-06T22:45:29.888049Z","caller":"traceutil/trace.go:171","msg":"trace[1777430783] linearizableReadLoop","detail":"{readStateIndex:23952; appliedIndex:23950; }","duration":"118.267255ms","start":"2026-03-06T22:45:29.769761Z","end":"2026-03-06T22:45:29.888028Z","steps":["trace[1777430783] 'read index received'  (duration: 116.258517ms)","trace[1777430783] 'applied index is now lower than readState.Index'  (duration: 2.007858ms)"],"step_count":2}
{"level":"info","ts":"2026-03-06T22:45:29.888166Z","caller":"traceutil/trace.go:171","msg":"trace[1889547617] transaction","detail":"{read_only:false; response_revision:23154; number_of_response:1; }","duration":"129.241184ms","start":"2026-03-06T22:45:29.75887Z","end":"2026-03-06T22:45:29.888111Z","steps":["trace[1889547617] 'process raft request'  (duration: 129.107541ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T22:45:29.888105Z","caller":"traceutil/trace.go:171","msg":"trace[399578357] transaction","detail":"{read_only:false; response_revision:23153; number_of_response:1; }","duration":"130.056383ms","start":"2026-03-06T22:45:29.758022Z","end":"2026-03-06T22:45:29.888078Z","steps":["trace[399578357] 'process raft request'  (duration: 127.971814ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T22:45:29.88893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.155975ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-03-06T22:45:29.889017Z","caller":"traceutil/trace.go:171","msg":"trace[979459770] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:23154; }","duration":"119.283549ms","start":"2026-03-06T22:45:29.769721Z","end":"2026-03-06T22:45:29.889005Z","steps":["trace[979459770] 'agreement among raft nodes before linearized reading'  (duration: 118.437229ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T22:45:30.389985Z","caller":"traceutil/trace.go:171","msg":"trace[1627896763] linearizableReadLoop","detail":"{readStateIndex:23954; appliedIndex:23953; }","duration":"150.728701ms","start":"2026-03-06T22:45:30.239231Z","end":"2026-03-06T22:45:30.38996Z","steps":["trace[1627896763] 'read index received'  (duration: 150.519356ms)","trace[1627896763] 'applied index is now lower than readState.Index'  (duration: 208.455µs)"],"step_count":2}
{"level":"info","ts":"2026-03-06T22:45:30.390074Z","caller":"traceutil/trace.go:171","msg":"trace[973618888] transaction","detail":"{read_only:false; response_revision:23156; number_of_response:1; }","duration":"209.683454ms","start":"2026-03-06T22:45:30.180348Z","end":"2026-03-06T22:45:30.390032Z","steps":["trace[973618888] 'process raft request'  (duration: 209.455588ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T22:45:30.390171Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.532317ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-03-06T22:45:30.390203Z","caller":"traceutil/trace.go:171","msg":"trace[1638595895] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:23156; }","duration":"109.61906ms","start":"2026-03-06T22:45:30.280577Z","end":"2026-03-06T22:45:30.390196Z","steps":["trace[1638595895] 'agreement among raft nodes before linearized reading'  (duration: 109.531498ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T22:45:30.390208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.025608ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"}
{"level":"info","ts":"2026-03-06T22:45:30.390256Z","caller":"traceutil/trace.go:171","msg":"trace[587133898] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:23156; }","duration":"151.125241ms","start":"2026-03-06T22:45:30.239119Z","end":"2026-03-06T22:45:30.390244Z","steps":["trace[587133898] 'agreement among raft nodes before linearized reading'  (duration: 150.967367ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T22:45:30.726452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.70292ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-03-06T22:45:30.726521Z","caller":"traceutil/trace.go:171","msg":"trace[2026916347] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:23157; }","duration":"133.856913ms","start":"2026-03-06T22:45:30.592649Z","end":"2026-03-06T22:45:30.726505Z","steps":["trace[2026916347] 'range keys from in-memory index tree'  (duration: 133.513175ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T22:45:30.72661Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.6202ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/servers/\" range_end:\"/registry/openstack.k-orc.cloud/servers0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-03-06T22:45:30.726706Z","caller":"traceutil/trace.go:171","msg":"trace[830691022] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/servers/; range_end:/registry/openstack.k-orc.cloud/servers0; response_count:0; response_revision:23157; }","duration":"120.780704ms","start":"2026-03-06T22:45:30.605903Z","end":"2026-03-06T22:45:30.726683Z","steps":["trace[830691022] 'count revisions from in-memory index tree'  (duration: 120.474486ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T22:45:30.933875Z","caller":"traceutil/trace.go:171","msg":"trace[733825072] transaction","detail":"{read_only:false; response_revision:23159; number_of_response:1; }","duration":"123.339294ms","start":"2026-03-06T22:45:30.810514Z","end":"2026-03-06T22:45:30.933854Z","steps":["trace[733825072] 'process raft request'  (duration: 121.569812ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T22:45:31.26761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.772437ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16594529622576278864 > lease_revoke:<id:664b9cc5285b2c4f>","response":"size:30"}
{"level":"info","ts":"2026-03-06T22:45:31.556056Z","caller":"traceutil/trace.go:171","msg":"trace[1968103486] transaction","detail":"{read_only:false; response_revision:23161; number_of_response:1; }","duration":"367.164345ms","start":"2026-03-06T22:45:31.188867Z","end":"2026-03-06T22:45:31.556031Z","steps":["trace[1968103486] 'process raft request'  (duration: 366.985691ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T22:45:31.556209Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T22:45:31.188843Z","time spent":"367.287438ms","remote":"127.0.0.1:44482","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:23149 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:477 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"info","ts":"2026-03-06T22:45:31.571007Z","caller":"traceutil/trace.go:171","msg":"trace[250109153] linearizableReadLoop","detail":"{readStateIndex:23963; appliedIndex:23959; }","duration":"139.213999ms","start":"2026-03-06T22:45:31.431775Z","end":"2026-03-06T22:45:31.570989Z","steps":["trace[250109153] 'read index received'  (duration: 124.138883ms)","trace[250109153] 'applied index is now lower than readState.Index'  (duration: 15.074546ms)"],"step_count":2}
{"level":"info","ts":"2026-03-06T22:45:31.571078Z","caller":"traceutil/trace.go:171","msg":"trace[180312196] transaction","detail":"{read_only:false; response_revision:23162; number_of_response:1; }","duration":"299.456195ms","start":"2026-03-06T22:45:31.271604Z","end":"2026-03-06T22:45:31.57106Z","steps":["trace[180312196] 'process raft request'  (duration: 297.680753ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T22:45:31.571145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.350592ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-03-06T22:45:31.571174Z","caller":"traceutil/trace.go:171","msg":"trace[1119333476] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:23164; }","duration":"139.435965ms","start":"2026-03-06T22:45:31.431732Z","end":"2026-03-06T22:45:31.571168Z","steps":["trace[1119333476] 'agreement among raft nodes before linearized reading'  (duration: 139.368313ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T22:45:31.571117Z","caller":"traceutil/trace.go:171","msg":"trace[1798263806] transaction","detail":"{read_only:false; response_revision:23163; number_of_response:1; }","duration":"222.922757ms","start":"2026-03-06T22:45:31.348141Z","end":"2026-03-06T22:45:31.571064Z","steps":["trace[1798263806] 'process raft request'  (duration: 222.787384ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T22:45:31.571162Z","caller":"traceutil/trace.go:171","msg":"trace[480262697] transaction","detail":"{read_only:false; response_revision:23164; number_of_response:1; }","duration":"174.750268ms","start":"2026-03-06T22:45:31.396376Z","end":"2026-03-06T22:45:31.571126Z","steps":["trace[480262697] 'process raft request'  (duration: 174.583654ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T22:45:31.888744Z","caller":"traceutil/trace.go:171","msg":"trace[951411904] linearizableReadLoop","detail":"{readStateIndex:23965; appliedIndex:23964; }","duration":"121.200874ms","start":"2026-03-06T22:45:31.767521Z","end":"2026-03-06T22:45:31.888722Z","steps":["trace[951411904] 'read index received'  (duration: 120.977468ms)","trace[951411904] 'applied index is now lower than readState.Index'  (duration: 222.526µs)"],"step_count":2}
{"level":"warn","ts":"2026-03-06T22:45:31.888928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.391138ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-03-06T22:45:31.888967Z","caller":"traceutil/trace.go:171","msg":"trace[1161595908] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:23166; }","duration":"121.4798ms","start":"2026-03-06T22:45:31.767478Z","end":"2026-03-06T22:45:31.888957Z","steps":["trace[1161595908] 'agreement among raft nodes before linearized reading'  (duration: 121.344307ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T22:45:31.889006Z","caller":"traceutil/trace.go:171","msg":"trace[1892749069] transaction","detail":"{read_only:false; response_revision:23166; number_of_response:1; }","duration":"150.334002ms","start":"2026-03-06T22:45:31.738632Z","end":"2026-03-06T22:45:31.888966Z","steps":["trace[1892749069] 'process raft request'  (duration: 149.930293ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T22:45:32.011563Z","caller":"traceutil/trace.go:171","msg":"trace[1279129546] transaction","detail":"{read_only:false; response_revision:23167; number_of_response:1; }","duration":"118.020659ms","start":"2026-03-06T22:45:31.893521Z","end":"2026-03-06T22:45:32.011541Z","steps":["trace[1279129546] 'process raft request'  (duration: 93.374456ms)","trace[1279129546] 'compare'  (duration: 24.476449ms)"],"step_count":2}
{"level":"info","ts":"2026-03-06T22:45:32.011747Z","caller":"traceutil/trace.go:171","msg":"trace[1374661583] linearizableReadLoop","detail":"{readStateIndex:23967; appliedIndex:23965; }","duration":"105.219907ms","start":"2026-03-06T22:45:31.906496Z","end":"2026-03-06T22:45:32.011716Z","steps":["trace[1374661583] 'read index received'  (duration: 80.414781ms)","trace[1374661583] 'applied index is now lower than readState.Index'  (duration: 24.803056ms)"],"step_count":2}
{"level":"info","ts":"2026-03-06T22:45:32.011772Z","caller":"traceutil/trace.go:171","msg":"trace[1074714108] transaction","detail":"{read_only:false; response_revision:23168; number_of_response:1; }","duration":"116.79115ms","start":"2026-03-06T22:45:31.894945Z","end":"2026-03-06T22:45:32.011737Z","steps":["trace[1074714108] 'process raft request'  (duration: 116.548584ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T22:45:32.011977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.461653ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"}
{"level":"info","ts":"2026-03-06T22:45:32.012052Z","caller":"traceutil/trace.go:171","msg":"trace[1045284717] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:23168; }","duration":"105.587075ms","start":"2026-03-06T22:45:31.906447Z","end":"2026-03-06T22:45:32.012034Z","steps":["trace[1045284717] 'agreement among raft nodes before linearized reading'  (duration: 105.36384ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T22:45:32.201097Z","caller":"traceutil/trace.go:171","msg":"trace[1187811725] linearizableReadLoop","detail":"{readStateIndex:23968; appliedIndex:23967; }","duration":"185.143335ms","start":"2026-03-06T22:45:32.015933Z","end":"2026-03-06T22:45:32.201076Z","steps":["trace[1187811725] 'read index received'  (duration: 141.543725ms)","trace[1187811725] 'applied index is now lower than readState.Index'  (duration: 43.59886ms)"],"step_count":2}
{"level":"info","ts":"2026-03-06T22:45:32.201187Z","caller":"traceutil/trace.go:171","msg":"trace[1920853221] transaction","detail":"{read_only:false; response_revision:23169; number_of_response:1; }","duration":"185.39256ms","start":"2026-03-06T22:45:32.015788Z","end":"2026-03-06T22:45:32.201181Z","steps":["trace[1920853221] 'process raft request'  (duration: 141.78769ms)","trace[1920853221] 'compare'  (duration: 43.403245ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-06T22:45:32.201356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.418791ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"}
{"level":"info","ts":"2026-03-06T22:45:32.201377Z","caller":"traceutil/trace.go:171","msg":"trace[1150922447] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:23169; }","duration":"185.505022ms","start":"2026-03-06T22:45:32.015868Z","end":"2026-03-06T22:45:32.201373Z","steps":["trace[1150922447] 'agreement among raft nodes before linearized reading'  (duration: 185.40276ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T22:45:32.201429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.147613ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-03-06T22:45:32.201526Z","caller":"traceutil/trace.go:171","msg":"trace[1507145114] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:23169; }","duration":"135.267097ms","start":"2026-03-06T22:45:32.066236Z","end":"2026-03-06T22:45:32.201503Z","steps":["trace[1507145114] 'agreement among raft nodes before linearized reading'  (duration: 135.097532ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T22:45:32.500777Z","caller":"traceutil/trace.go:171","msg":"trace[786331534] transaction","detail":"{read_only:false; response_revision:23170; number_of_response:1; }","duration":"105.971563ms","start":"2026-03-06T22:45:32.394769Z","end":"2026-03-06T22:45:32.500741Z","steps":["trace[786331534] 'process raft request'  (duration: 105.750307ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T22:45:32.636219Z","caller":"traceutil/trace.go:171","msg":"trace[1367313375] transaction","detail":"{read_only:false; response_revision:23171; number_of_response:1; }","duration":"130.163666ms","start":"2026-03-06T22:45:32.506028Z","end":"2026-03-06T22:45:32.636191Z","steps":["trace[1367313375] 'process raft request'  (duration: 82.459979ms)","trace[1367313375] 'compare'  (duration: 47.512772ms)"],"step_count":2}
{"level":"info","ts":"2026-03-06T22:45:33.041807Z","caller":"traceutil/trace.go:171","msg":"trace[1681658346] transaction","detail":"{read_only:false; response_revision:23173; number_of_response:1; }","duration":"102.070372ms","start":"2026-03-06T22:45:32.939706Z","end":"2026-03-06T22:45:33.041777Z","steps":["trace[1681658346] 'process raft request'  (duration: 89.084266ms)","trace[1681658346] 'compare'  (duration: 12.533855ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-06T22:45:33.550904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.844375ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16594529622576278904 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/openstack/container-infra-registry.189a61f5880ca125\" mod_revision:22980 > success:<request_put:<key:\"/registry/events/openstack/container-infra-registry.189a61f5880ca125\" value_size:618 lease:7371157585721501719 >> failure:<request_range:<key:\"/registry/events/openstack/container-infra-registry.189a61f5880ca125\" > >>","response":"size:18"}
{"level":"info","ts":"2026-03-06T22:45:33.55104Z","caller":"traceutil/trace.go:171","msg":"trace[586260153] transaction","detail":"{read_only:false; response_revision:23176; number_of_response:1; }","duration":"258.847525ms","start":"2026-03-06T22:45:33.292173Z","end":"2026-03-06T22:45:33.551021Z","steps":["trace[586260153] 'process raft request'  (duration: 145.803975ms)","trace[586260153] 'compare'  (duration: 112.434286ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-06T22:45:33.852273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.290399ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16594529622576278908 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/capi-system/controller-leader-election-capi\" mod_revision:23163 > success:<request_put:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" > >>","response":"size:18"}
{"level":"info","ts":"2026-03-06T22:45:33.852431Z","caller":"traceutil/trace.go:171","msg":"trace[1160354903] linearizableReadLoop","detail":"{readStateIndex:23978; appliedIndex:23977; }","duration":"270.085262ms","start":"2026-03-06T22:45:33.582326Z","end":"2026-03-06T22:45:33.852411Z","steps":["trace[1160354903] 'read index received'  (duration: 128.507307ms)","trace[1160354903] 'applied index is now lower than readState.Index'  (duration: 141.575695ms)"],"step_count":2}
{"level":"info","ts":"2026-03-06T22:45:33.852542Z","caller":"traceutil/trace.go:171","msg":"trace[828318896] transaction","detail":"{read_only:false; response_revision:23179; number_of_response:1; }","duration":"275.254913ms","start":"2026-03-06T22:45:33.577267Z","end":"2026-03-06T22:45:33.852522Z","steps":["trace[828318896] 'process raft request'  (duration: 133.619096ms)","trace[828318896] 'compare'  (duration: 141.173146ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-06T22:45:33.852776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.429665ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"}
{"level":"warn","ts":"2026-03-06T22:45:33.852777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.769504ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"}
{"level":"info","ts":"2026-03-06T22:45:33.852829Z","caller":"traceutil/trace.go:171","msg":"trace[1458131306] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:23179; }","duration":"208.860416ms","start":"2026-03-06T22:45:33.643955Z","end":"2026-03-06T22:45:33.852816Z","steps":["trace[1458131306] 'agreement among raft nodes before linearized reading'  (duration: 208.694702ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T22:45:33.852845Z","caller":"traceutil/trace.go:171","msg":"trace[1545584312] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:23179; }","duration":"277.476626ms","start":"2026-03-06T22:45:33.57533Z","end":"2026-03-06T22:45:33.852807Z","steps":["trace[1545584312] 'agreement among raft nodes before linearized reading'  (duration: 277.351833ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T22:45:34.131545Z","caller":"traceutil/trace.go:171","msg":"trace[1272211989] transaction","detail":"{read_only:false; response_revision:23180; number_of_response:1; }","duration":"274.731041ms","start":"2026-03-06T22:45:33.856773Z","end":"2026-03-06T22:45:34.131504Z","steps":["trace[1272211989] 'process raft request'  (duration: 233.435536ms)","trace[1272211989] 'compare'  (duration: 41.137351ms)"],"step_count":2}
{"level":"info","ts":"2026-03-06T22:45:34.137847Z","caller":"traceutil/trace.go:171","msg":"trace[973481586] transaction","detail":"{read_only:false; response_revision:23181; number_of_response:1; }","duration":"280.586649ms","start":"2026-03-06T22:45:33.857239Z","end":"2026-03-06T22:45:34.137826Z","steps":["trace[973481586] 'process raft request'  (duration: 280.430436ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T22:45:34.138249Z","caller":"traceutil/trace.go:171","msg":"trace[1291590468] transaction","detail":"{read_only:false; response_revision:23182; number_of_response:1; }","duration":"243.985555ms","start":"2026-03-06T22:45:33.894213Z","end":"2026-03-06T22:45:34.138198Z","steps":["trace[1291590468] 'process raft request'  (duration: 243.562215ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T22:45:34.138302Z","caller":"traceutil/trace.go:171","msg":"trace[1556182898] linearizableReadLoop","detail":"{readStateIndex:23981; appliedIndex:23978; }","duration":"235.457604ms","start":"2026-03-06T22:45:33.902819Z","end":"2026-03-06T22:45:34.138276Z","steps":["trace[1556182898] 'read index received'  (duration: 187.501541ms)","trace[1556182898] 'applied index is now lower than readState.Index'  (duration: 47.954953ms)"],"step_count":2}
{"level":"info","ts":"2026-03-06T22:45:34.138418Z","caller":"traceutil/trace.go:171","msg":"trace[576899578] transaction","detail":"{read_only:false; response_revision:23184; number_of_response:1; }","duration":"120.089537ms","start":"2026-03-06T22:45:34.018305Z","end":"2026-03-06T22:45:34.138395Z","steps":["trace[576899578] 'process raft request'  (duration: 119.914893ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T22:45:34.138438Z","caller":"traceutil/trace.go:171","msg":"trace[1355016009] transaction","detail":"{read_only:false; response_revision:23183; number_of_response:1; }","duration":"120.477857ms","start":"2026-03-06T22:45:34.017941Z","end":"2026-03-06T22:45:34.138419Z","steps":["trace[1355016009] 'process raft request'  (duration: 120.125889ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T22:45:34.138486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.633348ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/servicemonitors/\" range_end:\"/registry/monitoring.coreos.com/servicemonitors0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-03-06T22:45:34.13856Z","caller":"traceutil/trace.go:171","msg":"trace[1495091012] range","detail":"{range_begin:/registry/monitoring.coreos.com/servicemonitors/; range_end:/registry/monitoring.coreos.com/servicemonitors0; response_count:0; response_revision:23184; }","duration":"235.757001ms","start":"2026-03-06T22:45:33.902775Z","end":"2026-03-06T22:45:34.138532Z","steps":["trace[1495091012] 'agreement among raft nodes before linearized reading'  (duration: 235.597417ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T22:45:34.442808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.138744ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16594529622576278920 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:23169 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:18"}
{"level":"info","ts":"2026-03-06T22:45:34.442965Z","caller":"traceutil/trace.go:171","msg":"trace[263933896] transaction","detail":"{read_only:false; response_revision:23185; number_of_response:1; }","duration":"233.62285ms","start":"2026-03-06T22:45:34.209321Z","end":"2026-03-06T22:45:34.442943Z","steps":["trace[263933896] 'process raft request'  (duration: 67.068765ms)","trace[263933896] 'compare'  (duration: 166.010802ms)"],"step_count":2}
{"level":"info","ts":"2026-03-06T22:45:35.942036Z","caller":"traceutil/trace.go:171","msg":"trace[1297816124] linearizableReadLoop","detail":"{readStateIndex:23991; appliedIndex:23990; }","duration":"281.784158ms","start":"2026-03-06T22:45:35.660229Z","end":"2026-03-06T22:45:35.942013Z","steps":["trace[1297816124] 'read index received'  (duration: 281.708496ms)","trace[1297816124] 'applied index is now lower than readState.Index'  (duration: 74.042µs)"],"step_count":2}
{"level":"info","ts":"2026-03-06T22:45:35.942178Z","caller":"traceutil/trace.go:171","msg":"trace[744205110] transaction","detail":"{read_only:false; response_revision:23191; number_of_response:1; }","duration":"354.432075ms","start":"2026-03-06T22:45:35.587702Z","end":"2026-03-06T22:45:35.942134Z","steps":["trace[744205110] 'process raft request'  (duration: 354.168708ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T22:45:35.942273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.035834ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-neutron-server-0\" ","response":"range_response_count:1 size:1862"}
{"level":"info","ts":"2026-03-06T22:45:35.942322Z","caller":"traceutil/trace.go:171","msg":"trace[1048283207] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-neutron-server-0; range_end:; response_count:1; response_revision:23191; }","duration":"282.135507ms","start":"2026-03-06T22:45:35.660171Z","end":"2026-03-06T22:45:35.942307Z","steps":["trace[1048283207] 'agreement among raft nodes before linearized reading'  (duration: 281.960973ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T22:45:35.942476Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T22:45:35.587677Z","time spent":"354.586028ms","remote":"127.0.0.1:44482","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:23178 > 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-06T22:45:35.943729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.249367ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-03-06T22:45:35.943896Z","caller":"traceutil/trace.go:171","msg":"trace[1850324984] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:23193; }","duration":"174.422471ms","start":"2026-03-06T22:45:35.769414Z","end":"2026-03-06T22:45:35.943837Z","steps":["trace[1850324984] 'agreement among raft nodes before linearized reading'  (duration: 174.167485ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T22:45:47.848747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.145537ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-d50f963c-d9a0-429a-b89d-049e65a283e5\" ","response":"range_response_count:1 size:3643"}
{"level":"info","ts":"2026-03-06T22:45:47.848813Z","caller":"traceutil/trace.go:171","msg":"trace[95228752] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-d50f963c-d9a0-429a-b89d-049e65a283e5; range_end:; response_count:1; response_revision:23334; }","duration":"183.221129ms","start":"2026-03-06T22:45:47.665577Z","end":"2026-03-06T22:45:47.848799Z","steps":["trace[95228752] 'range keys from in-memory index tree'  (duration: 182.997164ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T22:45:48.120659Z","caller":"traceutil/trace.go:171","msg":"trace[124172766] transaction","detail":"{read_only:false; response_revision:23335; number_of_response:1; }","duration":"125.067595ms","start":"2026-03-06T22:45:47.995566Z","end":"2026-03-06T22:45:48.120633Z","steps":["trace[124172766] 'process raft request'  (duration: 124.8515ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T22:45:48.132643Z","caller":"traceutil/trace.go:171","msg":"trace[1162939991] transaction","detail":"{read_only:false; response_revision:23336; number_of_response:1; }","duration":"126.059488ms","start":"2026-03-06T22:45:48.00656Z","end":"2026-03-06T22:45:48.132619Z","steps":["trace[1162939991] 'process raft request'  (duration: 125.858063ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T22:45:48.352757Z","caller":"traceutil/trace.go:171","msg":"trace[336642635] transaction","detail":"{read_only:false; response_revision:23337; number_of_response:1; }","duration":"213.826392ms","start":"2026-03-06T22:45:48.138902Z","end":"2026-03-06T22:45:48.352729Z","steps":["trace[336642635] 'process raft request'  (duration: 213.664688ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T22:45:48.628063Z","caller":"traceutil/trace.go:171","msg":"trace[1104876051] transaction","detail":"{read_only:false; response_revision:23338; number_of_response:1; }","duration":"428.747491ms","start":"2026-03-06T22:45:48.199284Z","end":"2026-03-06T22:45:48.628032Z","steps":["trace[1104876051] 'process raft request'  (duration: 415.55656ms)","trace[1104876051] 'compare'  (duration: 12.72258ms)"],"step_count":2}
{"level":"info","ts":"2026-03-06T22:45:48.628147Z","caller":"traceutil/trace.go:171","msg":"trace[288235439] transaction","detail":"{read_only:false; response_revision:23339; number_of_response:1; }","duration":"428.121826ms","start":"2026-03-06T22:45:48.200002Z","end":"2026-03-06T22:45:48.628124Z","steps":["trace[288235439] 'process raft request'  (duration: 427.670765ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T22:45:48.628176Z","caller":"traceutil/trace.go:171","msg":"trace[208816126] transaction","detail":"{read_only:false; response_revision:23340; number_of_response:1; }","duration":"426.442836ms","start":"2026-03-06T22:45:48.201683Z","end":"2026-03-06T22:45:48.628125Z","steps":["trace[208816126] 'process raft request'  (duration: 426.053777ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T22:45:48.628256Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T22:45:48.199982Z","time spent":"428.211017ms","remote":"127.0.0.1:44482","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":539,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:23266 > 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-06T22:45:48.628243Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T22:45:48.199251Z","time spent":"428.893483ms","remote":"127.0.0.1:44482","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":497,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:23265 > success:<request_put:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" value_size:441 >> failure:<request_range:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" > >"}
{"level":"info","ts":"2026-03-06T22:45:48.628255Z","caller":"traceutil/trace.go:171","msg":"trace[1248746816] linearizableReadLoop","detail":"{readStateIndex:24143; appliedIndex:24139; }","duration":"424.169362ms","start":"2026-03-06T22:45:48.204034Z","end":"2026-03-06T22:45:48.628204Z","steps":["trace[1248746816] 'read index received'  (duration: 148.597861ms)","trace[1248746816] 'applied index is now lower than readState.Index'  (duration: 275.566161ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-06T22:45:48.628331Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T22:45:48.201652Z","time spent":"426.575969ms","remote":"127.0.0.1:44482","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/capo-system/controller-leader-election-capo\" mod_revision:23267 > success:<request_put:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" > >"}
{"level":"warn","ts":"2026-03-06T22:45:48.628487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.492219ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/ports/\" range_end:\"/registry/openstack.k-orc.cloud/ports0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-03-06T22:45:48.628519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"423.888735ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"}
{"level":"warn","ts":"2026-03-06T22:45:48.628498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"424.439618ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"}
{"level":"info","ts":"2026-03-06T22:45:48.628531Z","caller":"traceutil/trace.go:171","msg":"trace[761460696] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/ports/; range_end:/registry/openstack.k-orc.cloud/ports0; response_count:0; response_revision:23341; }","duration":"115.585061ms","start":"2026-03-06T22:45:48.512934Z","end":"2026-03-06T22:45:48.628519Z","steps":["trace[761460696] 'agreement among raft nodes before linearized reading'  (duration: 115.499289ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T22:45:48.628542Z","caller":"traceutil/trace.go:171","msg":"trace[26049530] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:23341; }","duration":"423.942186ms","start":"2026-03-06T22:45:48.204593Z","end":"2026-03-06T22:45:48.628535Z","steps":["trace[26049530] 'agreement among raft nodes before linearized reading'  (duration: 423.833574ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T22:45:48.628562Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T22:45:48.20458Z","time spent":"423.979148ms","remote":"127.0.0.1:44482","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":517,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"info","ts":"2026-03-06T22:45:48.628574Z","caller":"traceutil/trace.go:171","msg":"trace[2130468717] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:23341; }","duration":"424.559871ms","start":"2026-03-06T22:45:48.203994Z","end":"2026-03-06T22:45:48.628554Z","steps":["trace[2130468717] 'agreement among raft nodes before linearized reading'  (duration: 424.358086ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T22:45:48.628624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T22:45:48.203981Z","time spent":"424.633572ms","remote":"127.0.0.1:44482","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":464,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-03-06T22:45:48.628657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.742389ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"}
{"level":"info","ts":"2026-03-06T22:45:48.628722Z","caller":"traceutil/trace.go:171","msg":"trace[1926523318] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:23341; }","duration":"130.871971ms","start":"2026-03-06T22:45:48.497833Z","end":"2026-03-06T22:45:48.628705Z","steps":["trace[1926523318] 'agreement among raft nodes before linearized reading'  (duration: 130.615345ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T22:45:48.777388Z","caller":"traceutil/trace.go:171","msg":"trace[300127865] transaction","detail":"{read_only:false; response_revision:23343; number_of_response:1; }","duration":"144.048804ms","start":"2026-03-06T22:45:48.633302Z","end":"2026-03-06T22:45:48.777351Z","steps":["trace[300127865] 'process raft request'  (duration: 130.357031ms)","trace[300127865] 'compare'  (duration: 13.499108ms)"],"step_count":2}
{"level":"info","ts":"2026-03-06T22:45:48.777431Z","caller":"traceutil/trace.go:171","msg":"trace[56203427] transaction","detail":"{read_only:false; response_revision:23344; number_of_response:1; }","duration":"143.951361ms","start":"2026-03-06T22:45:48.633455Z","end":"2026-03-06T22:45:48.777406Z","steps":["trace[56203427] 'process raft request'  (duration: 143.798568ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T22:45:49.020565Z","caller":"traceutil/trace.go:171","msg":"trace[88362040] linearizableReadLoop","detail":"{readStateIndex:24148; appliedIndex:24147; }","duration":"167.990959ms","start":"2026-03-06T22:45:48.852543Z","end":"2026-03-06T22:45:49.020534Z","steps":["trace[88362040] 'read index received'  (duration: 85.48477ms)","trace[88362040] 'applied index is now lower than readState.Index'  (duration: 82.504839ms)"],"step_count":2}
{"level":"info","ts":"2026-03-06T22:45:49.020635Z","caller":"traceutil/trace.go:171","msg":"trace[1640175283] transaction","detail":"{read_only:false; response_revision:23345; number_of_response:1; }","duration":"240.079611ms","start":"2026-03-06T22:45:48.780516Z","end":"2026-03-06T22:45:49.020595Z","steps":["trace[1640175283] 'process raft request'  (duration: 157.495911ms)","trace[1640175283] 'compare'  (duration: 82.374566ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-06T22:45:49.020901Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.341628ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-d50f963c-d9a0-429a-b89d-049e65a283e5\" ","response":"range_response_count:1 size:3763"}
{"level":"warn","ts":"2026-03-06T22:45:49.020936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.300087ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-03-06T22:45:49.020978Z","caller":"traceutil/trace.go:171","msg":"trace[281731373] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-d50f963c-d9a0-429a-b89d-049e65a283e5; range_end:; response_count:1; response_revision:23345; }","duration":"168.431451ms","start":"2026-03-06T22:45:48.852526Z","end":"2026-03-06T22:45:49.020958Z","steps":["trace[281731373] 'agreement among raft nodes before linearized reading'  (duration: 168.213355ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T22:45:49.021021Z","caller":"traceutil/trace.go:171","msg":"trace[860052422] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:23345; }","duration":"135.41161ms","start":"2026-03-06T22:45:48.885572Z","end":"2026-03-06T22:45:49.020984Z","steps":["trace[860052422] 'agreement among raft nodes before linearized reading'  (duration: 135.196434ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T22:45:49.634861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.966587ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16594529622576279336 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:23327 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:453 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >>","response":"size:18"}
{"level":"info","ts":"2026-03-06T22:45:49.634966Z","caller":"traceutil/trace.go:171","msg":"trace[625367986] linearizableReadLoop","detail":"{readStateIndex:24150; appliedIndex:24149; }","duration":"206.459118ms","start":"2026-03-06T22:45:49.428493Z","end":"2026-03-06T22:45:49.634952Z","steps":["trace[625367986] 'read index received'  (duration: 80.352µs)","trace[625367986] 'applied index is now lower than readState.Index'  (duration: 206.377566ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-06T22:45:49.635051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.567581ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-03-06T22:45:49.63509Z","caller":"traceutil/trace.go:171","msg":"trace[1864541891] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/; range_end:/registry/apiregistration.k8s.io/apiservices0; response_count:0; response_revision:23347; }","duration":"206.644433ms","start":"2026-03-06T22:45:49.428434Z","end":"2026-03-06T22:45:49.635079Z","steps":["trace[1864541891] 'agreement among raft nodes before linearized reading'  (duration: 206.55415ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T22:45:49.635201Z","caller":"traceutil/trace.go:171","msg":"trace[1657442601] transaction","detail":"{read_only:false; response_revision:23347; number_of_response:1; }","duration":"525.477775ms","start":"2026-03-06T22:45:49.109682Z","end":"2026-03-06T22:45:49.63516Z","steps":["trace[1657442601] 'process raft request'  (duration: 250.123899ms)","trace[1657442601] 'compare'  (duration: 274.760913ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-06T22:45:49.635632Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T22:45:49.109653Z","time spent":"525.597799ms","remote":"127.0.0.1:44482","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":508,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:23327 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:453 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"warn","ts":"2026-03-06T22:45:49.915925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.242621ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-03-06T22:45:49.91598Z","caller":"traceutil/trace.go:171","msg":"trace[1008627589] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:23347; }","duration":"150.332382ms","start":"2026-03-06T22:45:49.765636Z","end":"2026-03-06T22:45:49.915968Z","steps":["trace[1008627589] 'range keys from in-memory index tree'  (duration: 150.144958ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T22:45:51.692417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.995225ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-03-06T22:45:51.692502Z","caller":"traceutil/trace.go:171","msg":"trace[1713939601] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:23361; }","duration":"120.140358ms","start":"2026-03-06T22:45:51.572342Z","end":"2026-03-06T22:45:51.692483Z","steps":["trace[1713939601] 'count revisions from in-memory index tree'  (duration: 119.888683ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T22:45:56.412146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.006824ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16594529622576279475 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/masterleases/162.253.55.52\" mod_revision:23261 > success:<request_put:<key:\"/registry/masterleases/162.253.55.52\" value_size:67 lease:7371157585721503664 >> failure:<request_range:<key:\"/registry/masterleases/162.253.55.52\" > >>","response":"size:18"}
{"level":"info","ts":"2026-03-06T22:45:56.412256Z","caller":"traceutil/trace.go:171","msg":"trace[529447132] linearizableReadLoop","detail":"{readStateIndex:24217; appliedIndex:24216; }","duration":"333.560511ms","start":"2026-03-06T22:45:56.078678Z","end":"2026-03-06T22:45:56.412238Z","steps":["trace[529447132] 'read index received'  (duration: 81.374083ms)","trace[529447132] 'applied index is now lower than readState.Index'  (duration: 252.184628ms)"],"step_count":2}
{"level":"info","ts":"2026-03-06T22:45:56.412306Z","caller":"traceutil/trace.go:171","msg":"trace[1977161463] transaction","detail":"{read_only:false; response_revision:23412; number_of_response:1; }","duration":"413.50361ms","start":"2026-03-06T22:45:55.998755Z","end":"2026-03-06T22:45:56.412259Z","steps":["trace[1977161463] 'process raft request'  (duration: 161.295511ms)","trace[1977161463] 'compare'  (duration: 251.732058ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-06T22:45:56.412354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"333.678174ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/clusters/\" range_end:\"/registry/cluster.x-k8s.io/clusters0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-03-06T22:45:56.412383Z","caller":"traceutil/trace.go:171","msg":"trace[159298073] range","detail":"{range_begin:/registry/cluster.x-k8s.io/clusters/; range_end:/registry/cluster.x-k8s.io/clusters0; response_count:0; response_revision:23412; }","duration":"333.742715ms","start":"2026-03-06T22:45:56.078631Z","end":"2026-03-06T22:45:56.412374Z","steps":["trace[159298073] 'agreement among raft nodes before linearized reading'  (duration: 333.653423ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T22:45:56.412405Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T22:45:55.998737Z","time spent":"413.620233ms","remote":"127.0.0.1:44270","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":119,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/masterleases/162.253.55.52\" mod_revision:23261 > success:<request_put:<key:\"/registry/masterleases/162.253.55.52\" value_size:67 lease:7371157585721503664 >> failure:<request_range:<key:\"/registry/masterleases/162.253.55.52\" > >"}
{"level":"warn","ts":"2026-03-06T22:45:56.412415Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T22:45:56.078612Z","time spent":"333.795836ms","remote":"127.0.0.1:34870","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":30,"request content":"key:\"/registry/cluster.x-k8s.io/clusters/\" range_end:\"/registry/cluster.x-k8s.io/clusters0\" count_only:true "}
{"level":"info","ts":"2026-03-06T22:45:56.43821Z","caller":"traceutil/trace.go:171","msg":"trace[2033760085] transaction","detail":"{read_only:false; response_revision:23413; number_of_response:1; }","duration":"296.114156ms","start":"2026-03-06T22:45:56.14206Z","end":"2026-03-06T22:45:56.438174Z","steps":["trace[2033760085] 'process raft request'  (duration: 295.85012ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T22:45:56.438267Z","caller":"traceutil/trace.go:171","msg":"trace[281831466] transaction","detail":"{read_only:false; response_revision:23414; number_of_response:1; }","duration":"279.403702ms","start":"2026-03-06T22:45:56.158811Z","end":"2026-03-06T22:45:56.438214Z","steps":["trace[281831466] 'process raft request'  (duration: 279.263769ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T22:45:56.844006Z","caller":"traceutil/trace.go:171","msg":"trace[1087872290] linearizableReadLoop","detail":"{readStateIndex:24223; appliedIndex:24220; }","duration":"131.65654ms","start":"2026-03-06T22:45:56.712326Z","end":"2026-03-06T22:45:56.843983Z","steps":["trace[1087872290] 'read index received'  (duration: 127.81249ms)","trace[1087872290] 'applied index is now lower than readState.Index'  (duration: 3.84276ms)"],"step_count":2}
{"level":"info","ts":"2026-03-06T22:45:56.84414Z","caller":"traceutil/trace.go:171","msg":"trace[2146108322] transaction","detail":"{read_only:false; response_revision:23417; number_of_response:1; }","duration":"188.434642ms","start":"2026-03-06T22:45:56.655694Z","end":"2026-03-06T22:45:56.844129Z","steps":["trace[2146108322] 'process raft request'  (duration: 188.173086ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T22:45:56.844166Z","caller":"traceutil/trace.go:171","msg":"trace[97705222] transaction","detail":"{read_only:false; response_revision:23416; number_of_response:1; }","duration":"188.577025ms","start":"2026-03-06T22:45:56.655533Z","end":"2026-03-06T22:45:56.84411Z","steps":["trace[97705222] 'process raft request'  (duration: 184.710264ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T22:45:56.844369Z","caller":"traceutil/trace.go:171","msg":"trace[41446791] transaction","detail":"{read_only:false; response_revision:23418; number_of_response:1; }","duration":"188.220467ms","start":"2026-03-06T22:45:56.656135Z","end":"2026-03-06T22:45:56.844355Z","steps":["trace[41446791] 'process raft request'  (duration: 187.796997ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T22:45:56.844571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.242134ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"}
{"level":"info","ts":"2026-03-06T22:45:56.844609Z","caller":"traceutil/trace.go:171","msg":"trace[81192980] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:23418; }","duration":"132.358347ms","start":"2026-03-06T22:45:56.712243Z","end":"2026-03-06T22:45:56.844601Z","steps":["trace[81192980] 'agreement among raft nodes before linearized reading'  (duration: 132.208273ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T22:46:06.223997Z","caller":"traceutil/trace.go:171","msg":"trace[1602192929] transaction","detail":"{read_only:false; response_revision:23490; number_of_response:1; }","duration":"164.132678ms","start":"2026-03-06T22:46:06.059837Z","end":"2026-03-06T22:46:06.22397Z","steps":["trace[1602192929] 'process raft request'  (duration: 164.038966ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T22:46:06.224032Z","caller":"traceutil/trace.go:171","msg":"trace[1049726318] transaction","detail":"{read_only:false; response_revision:23489; number_of_response:1; }","duration":"178.707752ms","start":"2026-03-06T22:46:06.045275Z","end":"2026-03-06T22:46:06.223983Z","steps":["trace[1049726318] 'process raft request'  (duration: 164.519507ms)","trace[1049726318] 'compare'  (duration: 13.10884ms)"],"step_count":2}
{"level":"info","ts":"2026-03-06T22:46:06.58839Z","caller":"traceutil/trace.go:171","msg":"trace[1881493519] transaction","detail":"{read_only:false; response_revision:23491; number_of_response:1; }","duration":"113.293997ms","start":"2026-03-06T22:46:06.475074Z","end":"2026-03-06T22:46:06.588368Z","steps":["trace[1881493519] 'process raft request'  (duration: 113.105992ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T22:46:06.920202Z","caller":"traceutil/trace.go:171","msg":"trace[571453116] transaction","detail":"{read_only:false; response_revision:23492; number_of_response:1; }","duration":"440.861796ms","start":"2026-03-06T22:46:06.479312Z","end":"2026-03-06T22:46:06.920174Z","steps":["trace[571453116] 'process raft request'  (duration: 440.60437ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T22:46:06.920398Z","caller":"traceutil/trace.go:171","msg":"trace[2066270326] linearizableReadLoop","detail":"{readStateIndex:24300; appliedIndex:24297; }","duration":"396.592031ms","start":"2026-03-06T22:46:06.523778Z","end":"2026-03-06T22:46:06.92037Z","steps":["trace[2066270326] 'read index received'  (duration: 64.441523ms)","trace[2066270326] 'applied index is now lower than readState.Index'  (duration: 332.148188ms)"],"step_count":2}
{"level":"info","ts":"2026-03-06T22:46:06.920513Z","caller":"traceutil/trace.go:171","msg":"trace[611070337] transaction","detail":"{read_only:false; response_revision:23493; number_of_response:1; }","duration":"409.969166ms","start":"2026-03-06T22:46:06.510526Z","end":"2026-03-06T22:46:06.920495Z","steps":["trace[611070337] 'process raft request'  (duration: 409.597737ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T22:46:06.920607Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T22:46:06.479303Z","time spent":"441.116232ms","remote":"127.0.0.1:44482","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/capi-system/controller-leader-election-capi\" mod_revision:23477 > success:<request_put:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" > >"}
{"level":"warn","ts":"2026-03-06T22:46:06.920634Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T22:46:06.510511Z","time spent":"410.038677ms","remote":"127.0.0.1:44482","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" mod_revision:23441 > success:<request_put:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" value_size:415 >> failure:<request_range:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" > >"}
{"level":"warn","ts":"2026-03-06T22:46:06.920646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"396.874297ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila\" ","response":"range_response_count:1 size:3309"}
{"level":"info","ts":"2026-03-06T22:46:06.92069Z","caller":"traceutil/trace.go:171","msg":"trace[1596484724] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila; range_end:; response_count:1; response_revision:23493; }","duration":"396.946909ms","start":"2026-03-06T22:46:06.523731Z","end":"2026-03-06T22:46:06.920678Z","steps":["trace[1596484724] 'agreement among raft nodes before linearized reading'  (duration: 396.746994ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T22:46:06.920722Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T22:46:06.523717Z","time spent":"396.99646ms","remote":"127.0.0.1:51136","response type":"/etcdserverpb.KV/Range","request count":0,"request size":67,"response count":1,"response size":3333,"request content":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila\" "}
{"level":"info","ts":"2026-03-06T22:46:07.101183Z","caller":"traceutil/trace.go:171","msg":"trace[1713423865] transaction","detail":"{read_only:false; response_revision:23494; number_of_response:1; }","duration":"376.984678ms","start":"2026-03-06T22:46:06.724173Z","end":"2026-03-06T22:46:07.101158Z","steps":["trace[1713423865] 'process raft request'  (duration: 330.94767ms)","trace[1713423865] 'compare'  (duration: 45.851793ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-06T22:46:07.101411Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T22:46:06.724148Z","time spent":"377.10118ms","remote":"127.0.0.1:44482","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":498,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:23478 > success:<request_put:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" value_size:442 >> failure:<request_range:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" > >"}
{"level":"info","ts":"2026-03-06T22:46:07.101482Z","caller":"traceutil/trace.go:171","msg":"trace[1203820940] transaction","detail":"{read_only:false; response_revision:23495; number_of_response:1; }","duration":"226.701786ms","start":"2026-03-06T22:46:06.874756Z","end":"2026-03-06T22:46:07.101457Z","steps":["trace[1203820940] 'process raft request'  (duration: 226.356808ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T22:46:07.101661Z","caller":"traceutil/trace.go:171","msg":"trace[1656332317] transaction","detail":"{read_only:false; response_revision:23496; number_of_response:1; }","duration":"222.378275ms","start":"2026-03-06T22:46:06.879263Z","end":"2026-03-06T22:46:07.101641Z","steps":["trace[1656332317] 'process raft request'  (duration: 222.076628ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T22:46:07.102085Z","caller":"traceutil/trace.go:171","msg":"trace[138727975] linearizableReadLoop","detail":"{readStateIndex:24304; appliedIndex:24300; }","duration":"181.605591ms","start":"2026-03-06T22:46:06.920458Z","end":"2026-03-06T22:46:07.102064Z","steps":["trace[138727975] 'read index received'  (duration: 134.58115ms)","trace[138727975] 'applied index is now lower than readState.Index'  (duration: 47.022381ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-06T22:46:07.102317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.304769ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"}
{"level":"warn","ts":"2026-03-06T22:46:07.102324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.706817ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/permissions/\" range_end:\"/registry/rabbitmq.com/permissions0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-03-06T22:46:07.102354Z","caller":"traceutil/trace.go:171","msg":"trace[430170766] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:23497; }","duration":"199.378071ms","start":"2026-03-06T22:46:06.902963Z","end":"2026-03-06T22:46:07.102341Z","steps":["trace[430170766] 'agreement among raft nodes before linearized reading'  (duration: 199.261868ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T22:46:07.102374Z","caller":"traceutil/trace.go:171","msg":"trace[1551482100] range","detail":"{range_begin:/registry/rabbitmq.com/permissions/; range_end:/registry/rabbitmq.com/permissions0; response_count:0; response_revision:23497; }","duration":"270.800219ms","start":"2026-03-06T22:46:06.831558Z","end":"2026-03-06T22:46:07.102358Z","steps":["trace[1551482100] 'agreement among raft nodes before linearized reading'  (duration: 270.706057ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T22:46:07.102422Z","caller":"traceutil/trace.go:171","msg":"trace[1289802017] transaction","detail":"{read_only:false; response_revision:23497; number_of_response:1; }","duration":"217.366586ms","start":"2026-03-06T22:46:06.885049Z","end":"2026-03-06T22:46:07.102416Z","steps":["trace[1289802017] 'process raft request'  (duration: 216.516617ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T22:46:07.102505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.352026ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"}
{"level":"info","ts":"2026-03-06T22:46:07.102526Z","caller":"traceutil/trace.go:171","msg":"trace[602001352] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:23497; }","duration":"198.409098ms","start":"2026-03-06T22:46:06.904112Z","end":"2026-03-06T22:46:07.102521Z","steps":["trace[602001352] 'agreement among raft nodes before linearized reading'  (duration: 198.356897ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T22:46:07.102578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.849421ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/clusters/\" range_end:\"/registry/cluster.x-k8s.io/clusters0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-03-06T22:46:07.102603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.661814ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"}
{"level":"info","ts":"2026-03-06T22:46:07.102619Z","caller":"traceutil/trace.go:171","msg":"trace[37288672] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:23497; }","duration":"198.691395ms","start":"2026-03-06T22:46:06.903923Z","end":"2026-03-06T22:46:07.102614Z","steps":["trace[37288672] 'agreement among raft nodes before linearized reading'  (duration: 198.642424ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T22:46:07.102631Z","caller":"traceutil/trace.go:171","msg":"trace[1714462926] range","detail":"{range_begin:/registry/cluster.x-k8s.io/clusters/; range_end:/registry/cluster.x-k8s.io/clusters0; response_count:0; response_revision:23497; }","duration":"229.916442ms","start":"2026-03-06T22:46:06.872691Z","end":"2026-03-06T22:46:07.102607Z","steps":["trace[1714462926] 'agreement among raft nodes before linearized reading'  (duration: 229.85713ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T22:46:07.404193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.585616ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16594529622576279683 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:23485 > 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:18"}
{"level":"info","ts":"2026-03-06T22:46:07.40435Z","caller":"traceutil/trace.go:171","msg":"trace[474693579] transaction","detail":"{read_only:false; response_revision:23498; number_of_response:1; }","duration":"298.454693ms","start":"2026-03-06T22:46:07.105865Z","end":"2026-03-06T22:46:07.40432Z","steps":["trace[474693579] 'process raft request'  (duration: 134.653282ms)","trace[474693579] 'compare'  (duration: 163.386821ms)"],"step_count":2}
{"level":"info","ts":"2026-03-06T22:46:07.415401Z","caller":"traceutil/trace.go:171","msg":"trace[1596444792] transaction","detail":"{read_only:false; response_revision:23499; number_of_response:1; }","duration":"308.606702ms","start":"2026-03-06T22:46:07.106763Z","end":"2026-03-06T22:46:07.41537Z","steps":["trace[1596444792] 'process raft request'  (duration: 308.411317ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T22:46:07.415744Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T22:46:07.106749Z","time spent":"308.895338ms","remote":"127.0.0.1:44482","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:23483 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-03-06T22:46:07.41626Z","caller":"traceutil/trace.go:171","msg":"trace[818985547] transaction","detail":"{read_only:false; response_revision:23500; number_of_response:1; }","duration":"309.284167ms","start":"2026-03-06T22:46:07.106956Z","end":"2026-03-06T22:46:07.41624Z","steps":["trace[818985547] 'process raft request'  (duration: 308.361675ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T22:46:07.41636Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T22:46:07.106931Z","time spent":"309.38638ms","remote":"127.0.0.1:44482","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:23484 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-03-06T22:46:07.41657Z","caller":"traceutil/trace.go:171","msg":"trace[606093308] linearizableReadLoop","detail":"{readStateIndex:24308; appliedIndex:24304; }","duration":"250.367115ms","start":"2026-03-06T22:46:07.166183Z","end":"2026-03-06T22:46:07.41655Z","steps":["trace[606093308] 'read index received'  (duration: 74.430638ms)","trace[606093308] 'applied index is now lower than readState.Index'  (duration: 175.935207ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-06T22:46:07.416867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.681252ms","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-06T22:46:07.41684Z","caller":"traceutil/trace.go:171","msg":"trace[1774657984] transaction","detail":"{read_only:false; response_revision:23501; number_of_response:1; }","duration":"309.485092ms","start":"2026-03-06T22:46:07.107279Z","end":"2026-03-06T22:46:07.416764Z","steps":["trace[1774657984] 'process raft request'  (duration: 308.639842ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T22:46:07.416905Z","caller":"traceutil/trace.go:171","msg":"trace[1231024032] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:23501; }","duration":"250.756994ms","start":"2026-03-06T22:46:07.166137Z","end":"2026-03-06T22:46:07.416895Z","steps":["trace[1231024032] 'agreement among raft nodes before linearized reading'  (duration: 250.635061ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T22:46:07.417636Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T22:46:07.107267Z","time spent":"310.26524ms","remote":"127.0.0.1:44482","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:23482 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-03-06T22:46:07.545209Z","caller":"traceutil/trace.go:171","msg":"trace[1046553482] linearizableReadLoop","detail":"{readStateIndex:24309; appliedIndex:24308; }","duration":"128.572558ms","start":"2026-03-06T22:46:07.416619Z","end":"2026-03-06T22:46:07.545192Z","steps":["trace[1046553482] 'read index received'  (duration: 110.86756ms)","trace[1046553482] 'applied index is now lower than readState.Index'  (duration: 17.704468ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-06T22:46:07.545299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.519727ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-03-06T22:46:07.54532Z","caller":"traceutil/trace.go:171","msg":"trace[1468893501] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:23502; }","duration":"343.594209ms","start":"2026-03-06T22:46:07.20172Z","end":"2026-03-06T22:46:07.545314Z","steps":["trace[1468893501] 'agreement among raft nodes before linearized reading'  (duration: 343.538807ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T22:46:07.545341Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T22:46:07.2017Z","time spent":"343.635049ms","remote":"127.0.0.1:44536","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":30,"request content":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true "}
{"level":"info","ts":"2026-03-06T22:46:07.546141Z","caller":"traceutil/trace.go:171","msg":"trace[22048595] transaction","detail":"{read_only:false; response_revision:23502; number_of_response:1; }","duration":"165.681124ms","start":"2026-03-06T22:46:07.3796Z","end":"2026-03-06T22:46:07.545281Z","steps":["trace[22048595] 'process raft request'  (duration: 147.877513ms)","trace[22048595] 'compare'  (duration: 17.636607ms)"],"step_count":2}
{"level":"info","ts":"2026-03-06T22:46:07.547178Z","caller":"traceutil/trace.go:171","msg":"trace[620594876] transaction","detail":"{read_only:false; response_revision:23503; number_of_response:1; }","duration":"125.608767ms","start":"2026-03-06T22:46:07.421552Z","end":"2026-03-06T22:46:07.547161Z","steps":["trace[620594876] 'process raft request'  (duration: 125.503665ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T22:46:19.783931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.909813ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16594529622576279946 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:23585 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:18"}
{"level":"info","ts":"2026-03-06T22:46:19.784067Z","caller":"traceutil/trace.go:171","msg":"trace[745422031] linearizableReadLoop","detail":"{readStateIndex:24409; appliedIndex:24407; }","duration":"192.439267ms","start":"2026-03-06T22:46:19.591613Z","end":"2026-03-06T22:46:19.784052Z","steps":["trace[745422031] 'read index received'  (duration: 50.305719ms)","trace[745422031] 'applied index is now lower than readState.Index'  (duration: 142.132778ms)"],"step_count":2}
{"level":"info","ts":"2026-03-06T22:46:19.784248Z","caller":"traceutil/trace.go:171","msg":"trace[1635390678] transaction","detail":"{read_only:false; response_revision:23600; number_of_response:1; }","duration":"250.845798ms","start":"2026-03-06T22:46:19.533365Z","end":"2026-03-06T22:46:19.78421Z","steps":["trace[1635390678] 'process raft request'  (duration: 250.640453ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T22:46:19.784353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.732663ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-03-06T22:46:19.784404Z","caller":"traceutil/trace.go:171","msg":"trace[1125254447] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:23600; }","duration":"192.826896ms","start":"2026-03-06T22:46:19.591565Z","end":"2026-03-06T22:46:19.784392Z","steps":["trace[1125254447] 'agreement among raft nodes before linearized reading'  (duration: 192.621071ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T22:46:19.784248Z","caller":"traceutil/trace.go:171","msg":"trace[1483270519] transaction","detail":"{read_only:false; response_revision:23599; number_of_response:1; }","duration":"251.017662ms","start":"2026-03-06T22:46:19.533188Z","end":"2026-03-06T22:46:19.784205Z","steps":["trace[1483270519] 'process raft request'  (duration: 108.75834ms)","trace[1483270519] 'compare'  (duration: 141.796741ms)"],"step_count":2}
{"level":"info","ts":"2026-03-06T22:46:20.003728Z","caller":"traceutil/trace.go:171","msg":"trace[599287001] transaction","detail":"{read_only:false; response_revision:23602; number_of_response:1; }","duration":"214.302293ms","start":"2026-03-06T22:46:19.789391Z","end":"2026-03-06T22:46:20.003693Z","steps":["trace[599287001] 'process raft request'  (duration: 142.958328ms)","trace[599287001] 'compare'  (duration: 71.1383ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-06T22:46:20.003838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.01106ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-03-06T22:46:20.003887Z","caller":"traceutil/trace.go:171","msg":"trace[1233038865] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:23602; }","duration":"135.119413ms","start":"2026-03-06T22:46:19.868757Z","end":"2026-03-06T22:46:20.003877Z","steps":["trace[1233038865] 'agreement among raft nodes before linearized reading'  (duration: 135.0077ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T22:46:20.003719Z","caller":"traceutil/trace.go:171","msg":"trace[1669927293] linearizableReadLoop","detail":"{readStateIndex:24411; appliedIndex:24410; }","duration":"134.841486ms","start":"2026-03-06T22:46:19.868822Z","end":"2026-03-06T22:46:20.003664Z","steps":["trace[1669927293] 'read index received'  (duration: 63.577122ms)","trace[1669927293] 'applied index is now lower than readState.Index'  (duration: 71.262583ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-06T22:46:21.216502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.447268ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16594529622576279958 > lease_revoke:<id:664b9cc5285b3072>","response":"size:30"}
{"level":"info","ts":"2026-03-06T22:47:19.237351Z","caller":"traceutil/trace.go:171","msg":"trace[256973271] transaction","detail":"{read_only:false; response_revision:24195; number_of_response:1; }","duration":"134.336654ms","start":"2026-03-06T22:47:19.102987Z","end":"2026-03-06T22:47:19.237324Z","steps":["trace[256973271] 'process raft request'  (duration: 90.713553ms)","trace[256973271] 'compare'  (duration: 43.527158ms)"],"step_count":2}
{"level":"info","ts":"2026-03-06T22:47:19.641259Z","caller":"traceutil/trace.go:171","msg":"trace[1986300363] transaction","detail":"{read_only:false; response_revision:24200; number_of_response:1; }","duration":"112.657572ms","start":"2026-03-06T22:47:19.528578Z","end":"2026-03-06T22:47:19.641236Z","steps":["trace[1986300363] 'process raft request'  (duration: 112.548599ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T22:47:19.641649Z","caller":"traceutil/trace.go:171","msg":"trace[1377143470] transaction","detail":"{read_only:false; response_revision:24199; number_of_response:1; }","duration":"114.125557ms","start":"2026-03-06T22:47:19.52728Z","end":"2026-03-06T22:47:19.641405Z","steps":["trace[1377143470] 'process raft request'  (duration: 93.455669ms)","trace[1377143470] 'compare'  (duration: 20.113945ms)"],"step_count":2}
{"level":"info","ts":"2026-03-06T22:47:20.038853Z","caller":"traceutil/trace.go:171","msg":"trace[2014508360] transaction","detail":"{read_only:false; response_revision:24203; number_of_response:1; }","duration":"121.06163ms","start":"2026-03-06T22:47:19.917766Z","end":"2026-03-06T22:47:20.038828Z","steps":["trace[2014508360] 'process raft request'  (duration: 119.508883ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T22:48:02.642769Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":21801}
{"level":"info","ts":"2026-03-06T22:48:02.774292Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":21801,"took":"127.762139ms","hash":3198549119,"current-db-size-bytes":52187136,"current-db-size":"52 MB","current-db-size-in-use-bytes":32260096,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-03-06T22:48:02.774364Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3198549119,"revision":21801,"compact-revision":18760}
{"level":"info","ts":"2026-03-06T22:53:02.648801Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":24556}
{"level":"info","ts":"2026-03-06T22:53:02.772788Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":24556,"took":"120.119708ms","hash":3824229786,"current-db-size-bytes":52187136,"current-db-size":"52 MB","current-db-size-in-use-bytes":33153024,"current-db-size-in-use":"33 MB"}
{"level":"info","ts":"2026-03-06T22:53:02.772843Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3824229786,"revision":24556,"compact-revision":21801}
{"level":"info","ts":"2026-03-06T22:57:49.15786Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"b11e7fc5714be64b","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-03-06T22:57:49.163448Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003}
{"level":"info","ts":"2026-03-06T22:57:49.163545Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003}
{"level":"info","ts":"2026-03-06T22:58:02.653842Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":27057}
{"level":"info","ts":"2026-03-06T22:58:02.777667Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":27057,"took":"119.816181ms","hash":1834726714,"current-db-size-bytes":52187136,"current-db-size":"52 MB","current-db-size-in-use-bytes":28049408,"current-db-size-in-use":"28 MB"}
{"level":"info","ts":"2026-03-06T22:58:02.777726Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1834726714,"revision":27057,"compact-revision":24556}
{"level":"info","ts":"2026-03-06T23:03:02.659557Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":29130}
{"level":"info","ts":"2026-03-06T23:03:02.801518Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":29130,"took":"138.410363ms","hash":2515511972,"current-db-size-bytes":52187136,"current-db-size":"52 MB","current-db-size-in-use-bytes":29073408,"current-db-size-in-use":"29 MB"}
{"level":"info","ts":"2026-03-06T23:03:02.801629Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2515511972,"revision":29130,"compact-revision":27057}
{"level":"info","ts":"2026-03-06T23:08:02.665445Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":31346}
{"level":"info","ts":"2026-03-06T23:08:02.814689Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":31346,"took":"145.123291ms","hash":3488466788,"current-db-size-bytes":52187136,"current-db-size":"52 MB","current-db-size-in-use-bytes":29409280,"current-db-size-in-use":"29 MB"}
{"level":"info","ts":"2026-03-06T23:08:02.81476Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3488466788,"revision":31346,"compact-revision":29130}
{"level":"info","ts":"2026-03-06T23:10:11.641007Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-0000000000008ad8.wal"}
{"level":"info","ts":"2026-03-06T23:13:02.671529Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":33499}
{"level":"info","ts":"2026-03-06T23:13:02.800072Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":33499,"took":"124.804461ms","hash":774652286,"current-db-size-bytes":54161408,"current-db-size":"54 MB","current-db-size-in-use-bytes":29351936,"current-db-size-in-use":"29 MB"}
{"level":"info","ts":"2026-03-06T23:13:02.800138Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":774652286,"revision":33499,"compact-revision":31346}