{"level":"warn","ts":"2026-09-02T16:26:52.351367Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-09-02T16:26:52.351454Z","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-09-02T16:26:52.351526Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-09-02T16:26:52.351534Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.52:2380"]}
{"level":"info","ts":"2026-09-02T16:26:52.351555Z","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-09-02T16:26:52.35217Z","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-09-02T16:26:52.352244Z","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-09-02T16:26:52.357016Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.55058ms"}
{"level":"info","ts":"2026-09-02T16:26:52.36195Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"b11e7fc5714be64b","cluster-id":"9349e4f32a52a90a"}
{"level":"info","ts":"2026-09-02T16:26:52.362372Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b switched to configuration voters=()"}
{"level":"info","ts":"2026-09-02T16:26:52.3624Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b became follower at term 0"}
{"level":"info","ts":"2026-09-02T16:26:52.362409Z","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-09-02T16:26:52.362419Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b became follower at term 1"}
{"level":"info","ts":"2026-09-02T16:26:52.362461Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b switched to configuration voters=(12762778880000648779)"}
{"level":"warn","ts":"2026-09-02T16:26:52.366802Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-09-02T16:26:52.368709Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-09-02T16:26:52.370224Z","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-09-02T16:26:52.372845Z","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-09-02T16:26:52.373109Z","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-09-02T16:26:52.373208Z","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-09-02T16:26:52.373375Z","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-09-02T16:26:52.37343Z","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-09-02T16:26:52.374458Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b switched to configuration voters=(12762778880000648779)"}
{"level":"info","ts":"2026-09-02T16:26:52.375519Z","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-09-02T16:26:52.378253Z","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-09-02T16:26:52.378379Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.52:2380"}
{"level":"info","ts":"2026-09-02T16:26:52.378425Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.52:2380"}
{"level":"info","ts":"2026-09-02T16:26:52.378598Z","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-09-02T16:26:52.378662Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-09-02T16:26:52.76354Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b is starting a new election at term 1"}
{"level":"info","ts":"2026-09-02T16:26:52.763596Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b became pre-candidate at term 1"}
{"level":"info","ts":"2026-09-02T16:26:52.763644Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b received MsgPreVoteResp from b11e7fc5714be64b at term 1"}
{"level":"info","ts":"2026-09-02T16:26:52.763662Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b became candidate at term 2"}
{"level":"info","ts":"2026-09-02T16:26:52.763672Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b received MsgVoteResp from b11e7fc5714be64b at term 2"}
{"level":"info","ts":"2026-09-02T16:26:52.763688Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b became leader at term 2"}
{"level":"info","ts":"2026-09-02T16:26:52.763705Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: b11e7fc5714be64b elected leader b11e7fc5714be64b at term 2"}
{"level":"info","ts":"2026-09-02T16:26:52.764877Z","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-09-02T16:26:52.764886Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-09-02T16:26:52.765007Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-09-02T16:26:52.765373Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-09-02T16:26:52.765571Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-09-02T16:26:52.765625Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-09-02T16:26:52.768274Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.52:2379"}
{"level":"info","ts":"2026-09-02T16:26:52.768547Z","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-09-02T16:26:52.768685Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-09-02T16:26:52.768727Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-09-02T16:26:52.768939Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"warn","ts":"2026-09-02T16:27:07.136909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.910241ms","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-09-02T16:27:07.137044Z","caller":"traceutil/trace.go:171","msg":"trace[653883754] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:363; }","duration":"146.128348ms","start":"2026-09-02T16:27:06.990893Z","end":"2026-09-02T16:27:07.137021Z","steps":["trace[653883754] 'range keys from in-memory index tree'  (duration: 145.724766ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T16:27:07.305209Z","caller":"traceutil/trace.go:171","msg":"trace[345321253] transaction","detail":"{read_only:false; response_revision:364; number_of_response:1; }","duration":"162.384338ms","start":"2026-09-02T16:27:07.142802Z","end":"2026-09-02T16:27:07.305186Z","steps":["trace[345321253] 'process raft request'  (duration: 162.237513ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T16:27:37.925877Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16594533598801579822,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-09-02T16:27:38.096227Z","caller":"traceutil/trace.go:171","msg":"trace[792432001] linearizableReadLoop","detail":"{readStateIndex:614; appliedIndex:613; }","duration":"671.083812ms","start":"2026-09-02T16:27:37.425111Z","end":"2026-09-02T16:27:38.096194Z","steps":["trace[792432001] 'read index received'  (duration: 669.942776ms)","trace[792432001] 'applied index is now lower than readState.Index'  (duration: 1.139786ms)"],"step_count":2}
{"level":"info","ts":"2026-09-02T16:27:38.096324Z","caller":"traceutil/trace.go:171","msg":"trace[1223985065] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"721.511598ms","start":"2026-09-02T16:27:37.37476Z","end":"2026-09-02T16:27:38.096271Z","steps":["trace[1223985065] 'process raft request'  (duration: 720.60409ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T16:27:38.09652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"671.37319ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-nl6c5\" ","response":"range_response_count:1 size:16961"}
{"level":"info","ts":"2026-09-02T16:27:38.096632Z","caller":"traceutil/trace.go:171","msg":"trace[899120717] range","detail":"{range_begin:/registry/pods/kube-system/cilium-nl6c5; range_end:; response_count:1; response_revision:592; }","duration":"671.466303ms","start":"2026-09-02T16:27:37.4251Z","end":"2026-09-02T16:27:38.096566Z","steps":["trace[899120717] 'agreement among raft nodes before linearized reading'  (duration: 671.248696ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T16:27:38.096728Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T16:27:37.425004Z","time spent":"671.68046ms","remote":"127.0.0.1:50996","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16985,"request content":"key:\"/registry/pods/kube-system/cilium-nl6c5\" "}
{"level":"warn","ts":"2026-09-02T16:27:38.09678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.590484ms","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-09-02T16:27:38.096763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"634.85373ms","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-09-02T16:27:38.096966Z","caller":"traceutil/trace.go:171","msg":"trace[214526678] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:592; }","duration":"353.818032ms","start":"2026-09-02T16:27:37.743084Z","end":"2026-09-02T16:27:38.096902Z","steps":["trace[214526678] 'agreement among raft nodes before linearized reading'  (duration: 353.497111ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T16:27:38.097028Z","caller":"traceutil/trace.go:171","msg":"trace[124622746] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:592; }","duration":"635.16176ms","start":"2026-09-02T16:27:37.461835Z","end":"2026-09-02T16:27:38.096996Z","steps":["trace[124622746] 'agreement among raft nodes before linearized reading'  (duration: 634.616002ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T16:27:38.097034Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T16:27:37.743042Z","time spent":"353.973316ms","remote":"127.0.0.1:51094","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-09-02T16:27:38.097083Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T16:27:37.461818Z","time spent":"635.249263ms","remote":"127.0.0.1:51094","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-09-02T16:27:38.097138Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T16:27:37.37472Z","time spent":"721.690773ms","remote":"127.0.0.1:50910","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036253,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" mod_revision:589 > success:<request_put:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" value_size:1036169 >> failure:<request_range:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" > >"}
{"level":"warn","ts":"2026-09-02T16:28:27.50795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.393192ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-02T16:28:27.508048Z","caller":"traceutil/trace.go:171","msg":"trace[765005491] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:1180; }","duration":"136.537988ms","start":"2026-09-02T16:28:27.37149Z","end":"2026-09-02T16:28:27.508028Z","steps":["trace[765005491] 'count revisions from in-memory index tree'  (duration: 136.247509ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T16:29:17.218547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.464227ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16594533598801582305 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:1789 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-09-02T16:29:17.218709Z","caller":"traceutil/trace.go:171","msg":"trace[1289002679] transaction","detail":"{read_only:false; response_revision:1853; number_of_response:1; }","duration":"474.588528ms","start":"2026-09-02T16:29:16.744098Z","end":"2026-09-02T16:29:17.218687Z","steps":["trace[1289002679] 'process raft request'  (duration: 323.72855ms)","trace[1289002679] 'compare'  (duration: 150.303131ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-02T16:29:17.218771Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T16:29:16.744067Z","time spent":"474.676181ms","remote":"127.0.0.1:51094","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:1789 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-09-02T16:29:17.663015Z","caller":"traceutil/trace.go:171","msg":"trace[530278993] transaction","detail":"{read_only:false; response_revision:1854; number_of_response:1; }","duration":"918.111265ms","start":"2026-09-02T16:29:16.744868Z","end":"2026-09-02T16:29:17.662979Z","steps":["trace[530278993] 'process raft request'  (duration: 902.348852ms)","trace[530278993] 'compare'  (duration: 15.280158ms)"],"step_count":2}
{"level":"info","ts":"2026-09-02T16:29:17.663067Z","caller":"traceutil/trace.go:171","msg":"trace[1525383415] transaction","detail":"{read_only:false; response_revision:1855; number_of_response:1; }","duration":"817.540117ms","start":"2026-09-02T16:29:16.845494Z","end":"2026-09-02T16:29:17.663035Z","steps":["trace[1525383415] 'process raft request'  (duration: 817.407262ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T16:29:17.663184Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T16:29:16.744834Z","time spent":"918.26336ms","remote":"127.0.0.1:51094","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:1788 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-09-02T16:29:17.663034Z","caller":"traceutil/trace.go:171","msg":"trace[1404244052] linearizableReadLoop","detail":"{readStateIndex:1929; appliedIndex:1926; }","duration":"735.467955ms","start":"2026-09-02T16:29:16.927539Z","end":"2026-09-02T16:29:17.663007Z","steps":["trace[1404244052] 'read index received'  (duration: 140.222073ms)","trace[1404244052] 'applied index is now lower than readState.Index'  (duration: 595.244772ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-02T16:29:17.663239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"735.700751ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-9dbbd2dd-9530-4445-bfb9-abfd155bda89\" ","response":"range_response_count:1 size:3626"}
{"level":"info","ts":"2026-09-02T16:29:17.663328Z","caller":"traceutil/trace.go:171","msg":"trace[2125283233] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-9dbbd2dd-9530-4445-bfb9-abfd155bda89; range_end:; response_count:1; response_revision:1855; }","duration":"735.837166ms","start":"2026-09-02T16:29:16.927475Z","end":"2026-09-02T16:29:17.663313Z","steps":["trace[2125283233] 'agreement among raft nodes before linearized reading'  (duration: 735.596789ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T16:29:17.66336Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T16:29:16.927445Z","time spent":"735.906747ms","remote":"127.0.0.1:50996","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3650,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-9dbbd2dd-9530-4445-bfb9-abfd155bda89\" "}
{"level":"warn","ts":"2026-09-02T16:29:17.663251Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T16:29:16.845454Z","time spent":"817.693031ms","remote":"127.0.0.1:51094","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:1795 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"warn","ts":"2026-09-02T16:29:17.672289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"613.854061ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"warn","ts":"2026-09-02T16:29:17.672375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"661.657513ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"}
{"level":"warn","ts":"2026-09-02T16:29:17.672363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"700.530514ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-09-02T16:29:17.672385Z","caller":"traceutil/trace.go:171","msg":"trace[821742346] transaction","detail":"{read_only:false; response_revision:1856; number_of_response:1; }","duration":"282.119896ms","start":"2026-09-02T16:29:17.390224Z","end":"2026-09-02T16:29:17.672343Z","steps":["trace[821742346] 'process raft request'  (duration: 281.701383ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T16:29:17.672421Z","caller":"traceutil/trace.go:171","msg":"trace[595249419] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:1856; }","duration":"614.055076ms","start":"2026-09-02T16:29:17.058339Z","end":"2026-09-02T16:29:17.672394Z","steps":["trace[595249419] 'agreement among raft nodes before linearized reading'  (duration: 613.82306ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T16:29:17.672469Z","caller":"traceutil/trace.go:171","msg":"trace[1160996595] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1856; }","duration":"661.806618ms","start":"2026-09-02T16:29:17.010635Z","end":"2026-09-02T16:29:17.672442Z","steps":["trace[1160996595] 'agreement among raft nodes before linearized reading'  (duration: 661.596192ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T16:29:17.672489Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T16:29:17.058323Z","time spent":"614.15323ms","remote":"127.0.0.1:51198","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":2,"response size":31,"request content":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true "}
{"level":"warn","ts":"2026-09-02T16:29:17.67242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"651.835873ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-9dbbd2dd-9530-4445-bfb9-abfd155bda89\" ","response":"range_response_count:1 size:3626"}
{"level":"warn","ts":"2026-09-02T16:29:17.672536Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T16:29:17.0106Z","time spent":"661.923551ms","remote":"127.0.0.1:33394","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5436,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "}
{"level":"info","ts":"2026-09-02T16:29:17.672472Z","caller":"traceutil/trace.go:171","msg":"trace[459976763] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1856; }","duration":"700.697779ms","start":"2026-09-02T16:29:16.971751Z","end":"2026-09-02T16:29:17.672449Z","steps":["trace[459976763] 'agreement among raft nodes before linearized reading'  (duration: 700.346849ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T16:29:17.672652Z","caller":"traceutil/trace.go:171","msg":"trace[1315901697] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-9dbbd2dd-9530-4445-bfb9-abfd155bda89; range_end:; response_count:1; response_revision:1856; }","duration":"652.036669ms","start":"2026-09-02T16:29:17.020508Z","end":"2026-09-02T16:29:17.672545Z","steps":["trace[1315901697] 'agreement among raft nodes before linearized reading'  (duration: 651.630347ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T16:29:17.672702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.491132ms","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-09-02T16:29:17.672763Z","caller":"traceutil/trace.go:171","msg":"trace[760663865] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1856; }","duration":"141.568785ms","start":"2026-09-02T16:29:17.53118Z","end":"2026-09-02T16:29:17.672749Z","steps":["trace[760663865] 'agreement among raft nodes before linearized reading'  (duration: 141.157442ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T16:29:17.672765Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T16:29:17.020502Z","time spent":"652.244317ms","remote":"127.0.0.1:50996","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3650,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-9dbbd2dd-9530-4445-bfb9-abfd155bda89\" "}
{"level":"warn","ts":"2026-09-02T16:29:17.672884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"586.400301ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-09-02T16:29:17.672655Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T16:29:16.971724Z","time spent":"700.911136ms","remote":"127.0.0.1:51094","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-09-02T16:29:17.672947Z","caller":"traceutil/trace.go:171","msg":"trace[2028011189] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1856; }","duration":"586.493613ms","start":"2026-09-02T16:29:17.086438Z","end":"2026-09-02T16:29:17.672932Z","steps":["trace[2028011189] 'agreement among raft nodes before linearized reading'  (duration: 585.676028ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T16:29:17.672979Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T16:29:17.086425Z","time spent":"586.545715ms","remote":"127.0.0.1:50810","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-09-02T16:29:31.494856Z","caller":"traceutil/trace.go:171","msg":"trace[1379408146] transaction","detail":"{read_only:false; response_revision:1976; number_of_response:1; }","duration":"195.264237ms","start":"2026-09-02T16:29:31.299559Z","end":"2026-09-02T16:29:31.494824Z","steps":["trace[1379408146] 'process raft request'  (duration: 195.053681ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T16:30:01.054783Z","caller":"traceutil/trace.go:171","msg":"trace[1470100118] linearizableReadLoop","detail":"{readStateIndex:2234; appliedIndex:2233; }","duration":"142.080931ms","start":"2026-09-02T16:30:00.912673Z","end":"2026-09-02T16:30:01.054754Z","steps":["trace[1470100118] 'read index received'  (duration: 141.831673ms)","trace[1470100118] 'applied index is now lower than readState.Index'  (duration: 247.608µs)"],"step_count":2}
{"level":"info","ts":"2026-09-02T16:30:01.054885Z","caller":"traceutil/trace.go:171","msg":"trace[1261804007] transaction","detail":"{read_only:false; response_revision:2151; number_of_response:1; }","duration":"166.494596ms","start":"2026-09-02T16:30:00.888352Z","end":"2026-09-02T16:30:01.054846Z","steps":["trace[1261804007] 'process raft request'  (duration: 166.252348ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T16:30:01.055052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.382501ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12382"}
{"level":"info","ts":"2026-09-02T16:30:01.055093Z","caller":"traceutil/trace.go:171","msg":"trace[207590235] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2151; }","duration":"142.499074ms","start":"2026-09-02T16:30:00.912583Z","end":"2026-09-02T16:30:01.055082Z","steps":["trace[207590235] 'agreement among raft nodes before linearized reading'  (duration: 142.309157ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T16:30:07.004926Z","caller":"traceutil/trace.go:171","msg":"trace[620723482] transaction","detail":"{read_only:false; response_revision:2184; number_of_response:1; }","duration":"110.475765ms","start":"2026-09-02T16:30:06.894389Z","end":"2026-09-02T16:30:07.004865Z","steps":["trace[620723482] 'process raft request'  (duration: 110.269689ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T16:30:07.291051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.811889ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16594533598801583063 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:2173 > 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\" > >>","response":"size:16"}
{"level":"info","ts":"2026-09-02T16:30:07.291174Z","caller":"traceutil/trace.go:171","msg":"trace[801460778] linearizableReadLoop","detail":"{readStateIndex:2271; appliedIndex:2270; }","duration":"205.472927ms","start":"2026-09-02T16:30:07.085682Z","end":"2026-09-02T16:30:07.291155Z","steps":["trace[801460778] 'read index received'  (duration: 50.42379ms)","trace[801460778] 'applied index is now lower than readState.Index'  (duration: 155.047967ms)"],"step_count":2}
{"level":"info","ts":"2026-09-02T16:30:07.291208Z","caller":"traceutil/trace.go:171","msg":"trace[1225397810] transaction","detail":"{read_only:false; response_revision:2185; number_of_response:1; }","duration":"216.6788ms","start":"2026-09-02T16:30:07.074495Z","end":"2026-09-02T16:30:07.291173Z","steps":["trace[1225397810] 'process raft request'  (duration: 61.632843ms)","trace[1225397810] 'compare'  (duration: 154.655455ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-02T16:30:07.291277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.602882ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-02T16:30:07.291314Z","caller":"traceutil/trace.go:171","msg":"trace[1379026179] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2185; }","duration":"205.671974ms","start":"2026-09-02T16:30:07.085631Z","end":"2026-09-02T16:30:07.291303Z","steps":["trace[1379026179] 'agreement among raft nodes before linearized reading'  (duration: 205.614813ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T16:30:07.291827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.018039ms","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-09-02T16:30:07.29189Z","caller":"traceutil/trace.go:171","msg":"trace[477105710] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2185; }","duration":"198.137594ms","start":"2026-09-02T16:30:07.093736Z","end":"2026-09-02T16:30:07.291873Z","steps":["trace[477105710] 'agreement among raft nodes before linearized reading'  (duration: 197.66646ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T16:31:34.330383Z","caller":"traceutil/trace.go:171","msg":"trace[9682460] linearizableReadLoop","detail":"{readStateIndex:2956; appliedIndex:2955; }","duration":"139.956439ms","start":"2026-09-02T16:31:34.190405Z","end":"2026-09-02T16:31:34.330361Z","steps":["trace[9682460] 'read index received'  (duration: 139.738992ms)","trace[9682460] 'applied index is now lower than readState.Index'  (duration: 216.647µs)"],"step_count":2}
{"level":"info","ts":"2026-09-02T16:31:34.330449Z","caller":"traceutil/trace.go:171","msg":"trace[312613995] transaction","detail":"{read_only:false; response_revision:2844; number_of_response:1; }","duration":"151.850252ms","start":"2026-09-02T16:31:34.17858Z","end":"2026-09-02T16:31:34.330431Z","steps":["trace[312613995] 'process raft request'  (duration: 151.639455ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T16:31:34.330603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.193075ms","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-09-02T16:31:34.330684Z","caller":"traceutil/trace.go:171","msg":"trace[876016002] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2844; }","duration":"140.32802ms","start":"2026-09-02T16:31:34.190345Z","end":"2026-09-02T16:31:34.330673Z","steps":["trace[876016002] 'agreement among raft nodes before linearized reading'  (duration: 140.124464ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T16:31:39.744415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.245576ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-09-02T16:31:39.744503Z","caller":"traceutil/trace.go:171","msg":"trace[84392580] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:2875; }","duration":"180.402022ms","start":"2026-09-02T16:31:39.564081Z","end":"2026-09-02T16:31:39.744483Z","steps":["trace[84392580] 'count revisions from in-memory index tree'  (duration: 180.175914ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T16:31:39.752426Z","caller":"traceutil/trace.go:171","msg":"trace[1008100255] transaction","detail":"{read_only:false; response_revision:2876; number_of_response:1; }","duration":"107.793057ms","start":"2026-09-02T16:31:39.64458Z","end":"2026-09-02T16:31:39.752373Z","steps":["trace[1008100255] 'process raft request'  (duration: 107.598472ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T16:34:41.189366Z","caller":"traceutil/trace.go:171","msg":"trace[1102844303] linearizableReadLoop","detail":"{readStateIndex:4187; appliedIndex:4186; }","duration":"104.398312ms","start":"2026-09-02T16:34:41.084943Z","end":"2026-09-02T16:34:41.189341Z","steps":["trace[1102844303] 'read index received'  (duration: 104.170005ms)","trace[1102844303] 'applied index is now lower than readState.Index'  (duration: 227.117µs)"],"step_count":2}
{"level":"info","ts":"2026-09-02T16:34:41.18944Z","caller":"traceutil/trace.go:171","msg":"trace[691345952] transaction","detail":"{read_only:false; response_revision:4031; number_of_response:1; }","duration":"162.994092ms","start":"2026-09-02T16:34:41.02642Z","end":"2026-09-02T16:34:41.189414Z","steps":["trace[691345952] 'process raft request'  (duration: 162.761935ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T16:34:41.18955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.590227ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-02T16:34:41.189577Z","caller":"traceutil/trace.go:171","msg":"trace[1062158081] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4031; }","duration":"104.68771ms","start":"2026-09-02T16:34:41.084881Z","end":"2026-09-02T16:34:41.189569Z","steps":["trace[1062158081] 'agreement among raft nodes before linearized reading'  (duration: 104.590967ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T16:36:13.401123Z","caller":"traceutil/trace.go:171","msg":"trace[372771397] transaction","detail":"{read_only:false; response_revision:5224; number_of_response:1; }","duration":"172.39122ms","start":"2026-09-02T16:36:13.228708Z","end":"2026-09-02T16:36:13.401099Z","steps":["trace[372771397] 'process raft request'  (duration: 163.755658ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T16:36:13.402354Z","caller":"traceutil/trace.go:171","msg":"trace[458137253] linearizableReadLoop","detail":"{readStateIndex:5426; appliedIndex:5424; }","duration":"160.316554ms","start":"2026-09-02T16:36:13.242014Z","end":"2026-09-02T16:36:13.40233Z","steps":["trace[458137253] 'read index received'  (duration: 150.496755ms)","trace[458137253] 'applied index is now lower than readState.Index'  (duration: 9.818799ms)"],"step_count":2}
{"level":"info","ts":"2026-09-02T16:36:13.402447Z","caller":"traceutil/trace.go:171","msg":"trace[1002539927] transaction","detail":"{read_only:false; response_revision:5225; number_of_response:1; }","duration":"162.794599ms","start":"2026-09-02T16:36:13.239627Z","end":"2026-09-02T16:36:13.402422Z","steps":["trace[1002539927] 'process raft request'  (duration: 162.50427ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T16:36:13.402556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.495029ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-09-02T16:36:13.402604Z","caller":"traceutil/trace.go:171","msg":"trace[337201610] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:5226; }","duration":"160.610972ms","start":"2026-09-02T16:36:13.241982Z","end":"2026-09-02T16:36:13.402593Z","steps":["trace[337201610] 'agreement among raft nodes before linearized reading'  (duration: 160.473778ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T16:36:13.402675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.66134ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12212"}
{"level":"info","ts":"2026-09-02T16:36:13.402716Z","caller":"traceutil/trace.go:171","msg":"trace[402563972] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5226; }","duration":"101.717362ms","start":"2026-09-02T16:36:13.300989Z","end":"2026-09-02T16:36:13.402707Z","steps":["trace[402563972] 'agreement among raft nodes before linearized reading'  (duration: 101.570897ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T16:36:15.448019Z","caller":"traceutil/trace.go:171","msg":"trace[553691467] linearizableReadLoop","detail":"{readStateIndex:5454; appliedIndex:5453; }","duration":"160.064156ms","start":"2026-09-02T16:36:15.287927Z","end":"2026-09-02T16:36:15.447991Z","steps":["trace[553691467] 'read index received'  (duration: 159.792247ms)","trace[553691467] 'applied index is now lower than readState.Index'  (duration: 270.719µs)"],"step_count":2}
{"level":"info","ts":"2026-09-02T16:36:15.44818Z","caller":"traceutil/trace.go:171","msg":"trace[1788661268] transaction","detail":"{read_only:false; response_revision:5251; number_of_response:1; }","duration":"168.163591ms","start":"2026-09-02T16:36:15.279937Z","end":"2026-09-02T16:36:15.448101Z","steps":["trace[1788661268] 'process raft request'  (duration: 167.855681ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T16:36:15.449298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.198339ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-8879661f-8c78-4c29-858e-6c180100d226\" ","response":"range_response_count:1 size:3600"}
{"level":"info","ts":"2026-09-02T16:36:15.449416Z","caller":"traceutil/trace.go:171","msg":"trace[687533975] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-8879661f-8c78-4c29-858e-6c180100d226; range_end:; response_count:1; response_revision:5251; }","duration":"161.443868ms","start":"2026-09-02T16:36:15.2879Z","end":"2026-09-02T16:36:15.449344Z","steps":["trace[687533975] 'agreement among raft nodes before linearized reading'  (duration: 160.235881ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T16:36:17.681274Z","caller":"traceutil/trace.go:171","msg":"trace[830341565] transaction","detail":"{read_only:false; response_revision:5285; number_of_response:1; }","duration":"133.406786ms","start":"2026-09-02T16:36:17.547844Z","end":"2026-09-02T16:36:17.681251Z","steps":["trace[830341565] 'process raft request'  (duration: 133.2226ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T16:36:30.050179Z","caller":"traceutil/trace.go:171","msg":"trace[424065090] transaction","detail":"{read_only:false; response_revision:5509; number_of_response:1; }","duration":"141.324226ms","start":"2026-09-02T16:36:29.908784Z","end":"2026-09-02T16:36:30.050108Z","steps":["trace[424065090] 'process raft request'  (duration: 140.980634ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T16:36:30.228593Z","caller":"traceutil/trace.go:171","msg":"trace[183594116] transaction","detail":"{read_only:false; response_revision:5511; number_of_response:1; }","duration":"174.439552ms","start":"2026-09-02T16:36:30.05412Z","end":"2026-09-02T16:36:30.228559Z","steps":["trace[183594116] 'process raft request'  (duration: 107.337513ms)","trace[183594116] 'compare'  (duration: 66.43788ms)"],"step_count":2}
{"level":"info","ts":"2026-09-02T16:36:30.228769Z","caller":"traceutil/trace.go:171","msg":"trace[1592654937] transaction","detail":"{read_only:false; response_revision:5512; number_of_response:1; }","duration":"128.596349ms","start":"2026-09-02T16:36:30.100148Z","end":"2026-09-02T16:36:30.228744Z","steps":["trace[1592654937] 'process raft request'  (duration: 128.157296ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T16:36:30.228813Z","caller":"traceutil/trace.go:171","msg":"trace[609772267] linearizableReadLoop","detail":"{readStateIndex:5722; appliedIndex:5720; }","duration":"173.557256ms","start":"2026-09-02T16:36:30.055245Z","end":"2026-09-02T16:36:30.228802Z","steps":["trace[609772267] 'read index received'  (duration: 39.884043ms)","trace[609772267] 'applied index is now lower than readState.Index'  (duration: 133.672103ms)"],"step_count":2}
{"level":"info","ts":"2026-09-02T16:36:30.229022Z","caller":"traceutil/trace.go:171","msg":"trace[1002340063] transaction","detail":"{read_only:false; response_revision:5513; number_of_response:1; }","duration":"128.487945ms","start":"2026-09-02T16:36:30.100523Z","end":"2026-09-02T16:36:30.229011Z","steps":["trace[1002340063] 'process raft request'  (duration: 127.878137ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T16:36:30.22907Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.807553ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-09-02T16:36:30.229102Z","caller":"traceutil/trace.go:171","msg":"trace[876122937] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5514; }","duration":"173.889215ms","start":"2026-09-02T16:36:30.055204Z","end":"2026-09-02T16:36:30.229093Z","steps":["trace[876122937] 'agreement among raft nodes before linearized reading'  (duration: 173.71424ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T16:36:30.229325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.532217ms","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-09-02T16:36:30.229359Z","caller":"traceutil/trace.go:171","msg":"trace[589311414] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5514; }","duration":"152.583428ms","start":"2026-09-02T16:36:30.076766Z","end":"2026-09-02T16:36:30.22935Z","steps":["trace[589311414] 'agreement among raft nodes before linearized reading'  (duration: 152.496145ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T16:36:30.229587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.061849ms","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-09-02T16:36:30.229618Z","caller":"traceutil/trace.go:171","msg":"trace[1298019094] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5514; }","duration":"144.113721ms","start":"2026-09-02T16:36:30.085497Z","end":"2026-09-02T16:36:30.229611Z","steps":["trace[1298019094] 'agreement among raft nodes before linearized reading'  (duration: 144.028568ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T16:36:30.229758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.002118ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-02T16:36:30.229806Z","caller":"traceutil/trace.go:171","msg":"trace[842854992] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5514; }","duration":"145.0821ms","start":"2026-09-02T16:36:30.08471Z","end":"2026-09-02T16:36:30.229792Z","steps":["trace[842854992] 'agreement among raft nodes before linearized reading'  (duration: 145.000668ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T16:36:30.736732Z","caller":"traceutil/trace.go:171","msg":"trace[1646061372] transaction","detail":"{read_only:false; response_revision:5519; number_of_response:1; }","duration":"249.983369ms","start":"2026-09-02T16:36:30.486708Z","end":"2026-09-02T16:36:30.736691Z","steps":["trace[1646061372] 'process raft request'  (duration: 249.761173ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T16:36:30.751912Z","caller":"traceutil/trace.go:171","msg":"trace[586187937] transaction","detail":"{read_only:false; response_revision:5521; number_of_response:1; }","duration":"201.531946ms","start":"2026-09-02T16:36:30.550339Z","end":"2026-09-02T16:36:30.751871Z","steps":["trace[586187937] 'process raft request'  (duration: 201.368841ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T16:36:30.752625Z","caller":"traceutil/trace.go:171","msg":"trace[1921119384] transaction","detail":"{read_only:false; response_revision:5520; number_of_response:1; }","duration":"254.173416ms","start":"2026-09-02T16:36:30.498437Z","end":"2026-09-02T16:36:30.75261Z","steps":["trace[1921119384] 'process raft request'  (duration: 253.065543ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T16:36:40.531776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.599948ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16594533598801591488 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:5624 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:16"}
{"level":"info","ts":"2026-09-02T16:36:40.531904Z","caller":"traceutil/trace.go:171","msg":"trace[2120768411] linearizableReadLoop","detail":"{readStateIndex:5927; appliedIndex:5926; }","duration":"197.218776ms","start":"2026-09-02T16:36:40.334666Z","end":"2026-09-02T16:36:40.531885Z","steps":["trace[2120768411] 'read index received'  (duration: 47.420592ms)","trace[2120768411] 'applied index is now lower than readState.Index'  (duration: 149.796534ms)"],"step_count":2}
{"level":"info","ts":"2026-09-02T16:36:40.532173Z","caller":"traceutil/trace.go:171","msg":"trace[1128541941] transaction","detail":"{read_only:false; response_revision:5711; number_of_response:1; }","duration":"234.249091ms","start":"2026-09-02T16:36:40.297895Z","end":"2026-09-02T16:36:40.532144Z","steps":["trace[1128541941] 'process raft request'  (duration: 84.177189ms)","trace[1128541941] 'compare'  (duration: 149.448722ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-02T16:36:40.53233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.620397ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"}
{"level":"warn","ts":"2026-09-02T16:36:40.53237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.061419ms","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-09-02T16:36:40.532457Z","caller":"traceutil/trace.go:171","msg":"trace[2112095616] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5711; }","duration":"197.789532ms","start":"2026-09-02T16:36:40.334648Z","end":"2026-09-02T16:36:40.532438Z","steps":["trace[2112095616] 'agreement among raft nodes before linearized reading'  (duration: 197.485693ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T16:36:40.532447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.835682ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-09-02T16:36:40.532531Z","caller":"traceutil/trace.go:171","msg":"trace[1957088422] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5711; }","duration":"195.264665ms","start":"2026-09-02T16:36:40.337241Z","end":"2026-09-02T16:36:40.532505Z","steps":["trace[1957088422] 'agreement among raft nodes before linearized reading'  (duration: 194.897004ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T16:36:40.53257Z","caller":"traceutil/trace.go:171","msg":"trace[627092230] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5711; }","duration":"194.992057ms","start":"2026-09-02T16:36:40.337554Z","end":"2026-09-02T16:36:40.532546Z","steps":["trace[627092230] 'agreement among raft nodes before linearized reading'  (duration: 194.649537ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T16:36:40.770543Z","caller":"traceutil/trace.go:171","msg":"trace[757469449] transaction","detail":"{read_only:false; response_revision:5716; number_of_response:1; }","duration":"153.61798ms","start":"2026-09-02T16:36:40.616865Z","end":"2026-09-02T16:36:40.770483Z","steps":["trace[757469449] 'process raft request'  (duration: 151.888898ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T16:36:40.770592Z","caller":"traceutil/trace.go:171","msg":"trace[996829628] linearizableReadLoop","detail":"{readStateIndex:5932; appliedIndex:5931; }","duration":"144.420279ms","start":"2026-09-02T16:36:40.626143Z","end":"2026-09-02T16:36:40.770563Z","steps":["trace[996829628] 'read index received'  (duration: 142.768539ms)","trace[996829628] 'applied index is now lower than readState.Index'  (duration: 1.64618ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-02T16:36:40.77133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.156763ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-02T16:36:40.771402Z","caller":"traceutil/trace.go:171","msg":"trace[1741869677] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5717; }","duration":"145.278297ms","start":"2026-09-02T16:36:40.626103Z","end":"2026-09-02T16:36:40.771381Z","steps":["trace[1741869677] 'agreement among raft nodes before linearized reading'  (duration: 144.589735ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T16:36:40.771577Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.682732ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/storage-loki-0\" ","response":"range_response_count:1 size:1781"}
{"level":"info","ts":"2026-09-02T16:36:40.771798Z","caller":"traceutil/trace.go:171","msg":"trace[38277439] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/storage-loki-0; range_end:; response_count:1; response_revision:5717; }","duration":"130.784235ms","start":"2026-09-02T16:36:40.640845Z","end":"2026-09-02T16:36:40.771629Z","steps":["trace[38277439] 'agreement among raft nodes before linearized reading'  (duration: 130.376343ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T16:36:52.707793Z","caller":"traceutil/trace.go:171","msg":"trace[899895830] transaction","detail":"{read_only:false; response_revision:5843; number_of_response:1; }","duration":"117.012357ms","start":"2026-09-02T16:36:52.590754Z","end":"2026-09-02T16:36:52.707767Z","steps":["trace[899895830] 'process raft request'  (duration: 116.826561ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T16:36:52.717875Z","caller":"traceutil/trace.go:171","msg":"trace[1475814575] linearizableReadLoop","detail":"{readStateIndex:6063; appliedIndex:6061; }","duration":"110.344555ms","start":"2026-09-02T16:36:52.607515Z","end":"2026-09-02T16:36:52.717859Z","steps":["trace[1475814575] 'read index received'  (duration: 100.141365ms)","trace[1475814575] 'applied index is now lower than readState.Index'  (duration: 10.201999ms)"],"step_count":2}
{"level":"info","ts":"2026-09-02T16:36:52.71801Z","caller":"traceutil/trace.go:171","msg":"trace[937438662] transaction","detail":"{read_only:false; response_revision:5844; number_of_response:1; }","duration":"123.568295ms","start":"2026-09-02T16:36:52.594391Z","end":"2026-09-02T16:36:52.71796Z","steps":["trace[937438662] 'process raft request'  (duration: 123.400461ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T16:36:52.718323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.862178ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"}
{"level":"info","ts":"2026-09-02T16:36:52.718537Z","caller":"traceutil/trace.go:171","msg":"trace[1259070633] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5844; }","duration":"109.108017ms","start":"2026-09-02T16:36:52.609368Z","end":"2026-09-02T16:36:52.718476Z","steps":["trace[1259070633] 'agreement among raft nodes before linearized reading'  (duration: 108.662823ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T16:36:52.71861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.994855ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-09-02T16:36:52.719074Z","caller":"traceutil/trace.go:171","msg":"trace[2067667795] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5844; }","duration":"111.568181ms","start":"2026-09-02T16:36:52.607491Z","end":"2026-09-02T16:36:52.719059Z","steps":["trace[2067667795] 'agreement among raft nodes before linearized reading'  (duration: 110.469048ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T16:36:52.975002Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2949}
{"level":"info","ts":"2026-09-02T16:36:53.186151Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2949,"took":"209.500679ms","hash":2978668938,"current-db-size-bytes":57520128,"current-db-size":"58 MB","current-db-size-in-use-bytes":32198656,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-09-02T16:36:53.186276Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2978668938,"revision":2949,"compact-revision":-1}
{"level":"info","ts":"2026-09-02T16:41:52.982216Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5849}
{"level":"info","ts":"2026-09-02T16:41:53.072401Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5849,"took":"88.460017ms","hash":2472428584,"current-db-size-bytes":57520128,"current-db-size":"58 MB","current-db-size-in-use-bytes":26509312,"current-db-size-in-use":"26 MB"}
{"level":"info","ts":"2026-09-02T16:41:53.072469Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2472428584,"revision":5849,"compact-revision":2949}
{"level":"info","ts":"2026-09-02T16:43:02.97526Z","caller":"traceutil/trace.go:171","msg":"trace[1265970311] transaction","detail":"{read_only:false; response_revision:8604; number_of_response:1; }","duration":"285.225595ms","start":"2026-09-02T16:43:02.689996Z","end":"2026-09-02T16:43:02.975222Z","steps":["trace[1265970311] 'process raft request'  (duration: 285.030549ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T16:43:02.997727Z","caller":"traceutil/trace.go:171","msg":"trace[571007710] linearizableReadLoop","detail":"{readStateIndex:8914; appliedIndex:8912; }","duration":"209.205828ms","start":"2026-09-02T16:43:02.788491Z","end":"2026-09-02T16:43:02.997697Z","steps":["trace[571007710] 'read index received'  (duration: 186.64063ms)","trace[571007710] 'applied index is now lower than readState.Index'  (duration: 22.563808ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-02T16:43:02.998106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.460469ms","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-09-02T16:43:02.998175Z","caller":"traceutil/trace.go:171","msg":"trace[286178362] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8605; }","duration":"194.604223ms","start":"2026-09-02T16:43:02.803554Z","end":"2026-09-02T16:43:02.998158Z","steps":["trace[286178362] 'agreement among raft nodes before linearized reading'  (duration: 194.303124ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T16:43:02.998129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.59981ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"warn","ts":"2026-09-02T16:43:02.998183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.241259ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"}
{"level":"info","ts":"2026-09-02T16:43:02.998265Z","caller":"traceutil/trace.go:171","msg":"trace[1223193064] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8605; }","duration":"209.806336ms","start":"2026-09-02T16:43:02.788429Z","end":"2026-09-02T16:43:02.998235Z","steps":["trace[1223193064] 'agreement among raft nodes before linearized reading'  (duration: 209.416304ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T16:43:02.998313Z","caller":"traceutil/trace.go:171","msg":"trace[326609649] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8605; }","duration":"188.455256ms","start":"2026-09-02T16:43:02.809836Z","end":"2026-09-02T16:43:02.998291Z","steps":["trace[326609649] 'agreement among raft nodes before linearized reading'  (duration: 188.076674ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T16:43:02.998972Z","caller":"traceutil/trace.go:171","msg":"trace[1261238935] transaction","detail":"{read_only:false; response_revision:8605; number_of_response:1; }","duration":"303.39657ms","start":"2026-09-02T16:43:02.694425Z","end":"2026-09-02T16:43:02.997821Z","steps":["trace[1261238935] 'process raft request'  (duration: 303.070169ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T16:43:02.999129Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T16:43:02.694411Z","time spent":"304.626627ms","remote":"127.0.0.1:51094","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:8596 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-09-02T16:43:03.171167Z","caller":"traceutil/trace.go:171","msg":"trace[1337165961] transaction","detail":"{read_only:false; response_revision:8606; number_of_response:1; }","duration":"167.893008ms","start":"2026-09-02T16:43:03.003255Z","end":"2026-09-02T16:43:03.171148Z","steps":["trace[1337165961] 'process raft request'  (duration: 146.072174ms)","trace[1337165961] 'compare'  (duration: 21.395782ms)"],"step_count":2}
{"level":"info","ts":"2026-09-02T16:43:03.174683Z","caller":"traceutil/trace.go:171","msg":"trace[1523041194] transaction","detail":"{read_only:false; response_revision:8607; number_of_response:1; }","duration":"171.343695ms","start":"2026-09-02T16:43:03.003304Z","end":"2026-09-02T16:43:03.174647Z","steps":["trace[1523041194] 'process raft request'  (duration: 171.064536ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T16:43:03.174861Z","caller":"traceutil/trace.go:171","msg":"trace[465015813] transaction","detail":"{read_only:false; response_revision:8608; number_of_response:1; }","duration":"171.417586ms","start":"2026-09-02T16:43:03.003433Z","end":"2026-09-02T16:43:03.17485Z","steps":["trace[465015813] 'process raft request'  (duration: 171.158908ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T16:43:13.203037Z","caller":"traceutil/trace.go:171","msg":"trace[772724565] linearizableReadLoop","detail":"{readStateIndex:8971; appliedIndex:8970; }","duration":"117.380429ms","start":"2026-09-02T16:43:13.085617Z","end":"2026-09-02T16:43:13.202997Z","steps":["trace[772724565] 'read index received'  (duration: 100.912907ms)","trace[772724565] 'applied index is now lower than readState.Index'  (duration: 16.466012ms)"],"step_count":2}
{"level":"info","ts":"2026-09-02T16:43:13.203192Z","caller":"traceutil/trace.go:171","msg":"trace[415703400] transaction","detail":"{read_only:false; response_revision:8660; number_of_response:1; }","duration":"126.208288ms","start":"2026-09-02T16:43:13.076919Z","end":"2026-09-02T16:43:13.203127Z","steps":["trace[415703400] 'process raft request'  (duration: 109.705725ms)","trace[415703400] 'compare'  (duration: 16.169923ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-02T16:43:13.203271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.613496ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-02T16:43:13.203377Z","caller":"traceutil/trace.go:171","msg":"trace[555677119] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8660; }","duration":"117.806952ms","start":"2026-09-02T16:43:13.085549Z","end":"2026-09-02T16:43:13.203356Z","steps":["trace[555677119] 'agreement among raft nodes before linearized reading'  (duration: 117.600615ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T16:43:13.511883Z","caller":"traceutil/trace.go:171","msg":"trace[1059012220] transaction","detail":"{read_only:false; response_revision:8665; number_of_response:1; }","duration":"101.699121ms","start":"2026-09-02T16:43:13.410094Z","end":"2026-09-02T16:43:13.511793Z","steps":["trace[1059012220] 'process raft request'  (duration: 101.275797ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T16:43:13.849866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.194ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-02T16:43:13.849943Z","caller":"traceutil/trace.go:171","msg":"trace[1300418362] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:8665; }","duration":"255.333634ms","start":"2026-09-02T16:43:13.594592Z","end":"2026-09-02T16:43:13.849925Z","steps":["trace[1300418362] 'range keys from in-memory index tree'  (duration: 255.048875ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T16:43:14.646167Z","caller":"traceutil/trace.go:171","msg":"trace[1564533304] transaction","detail":"{read_only:false; response_revision:8667; number_of_response:1; }","duration":"134.624414ms","start":"2026-09-02T16:43:14.511515Z","end":"2026-09-02T16:43:14.64614Z","steps":["trace[1564533304] 'process raft request'  (duration: 134.296044ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T16:43:15.376471Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002314.wal"}
{"level":"info","ts":"2026-09-02T16:43:15.377151Z","caller":"traceutil/trace.go:171","msg":"trace[740468165] linearizableReadLoop","detail":"{readStateIndex:8979; appliedIndex:8978; }","duration":"290.916739ms","start":"2026-09-02T16:43:15.086188Z","end":"2026-09-02T16:43:15.377104Z","steps":["trace[740468165] 'read index received'  (duration: 290.59108ms)","trace[740468165] 'applied index is now lower than readState.Index'  (duration: 323.549µs)"],"step_count":2}
{"level":"warn","ts":"2026-09-02T16:43:15.377445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.24353ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-02T16:43:15.377504Z","caller":"traceutil/trace.go:171","msg":"trace[736551392] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8668; }","duration":"291.364423ms","start":"2026-09-02T16:43:15.08612Z","end":"2026-09-02T16:43:15.377485Z","steps":["trace[736551392] 'agreement among raft nodes before linearized reading'  (duration: 291.25905ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T16:43:15.377805Z","caller":"traceutil/trace.go:171","msg":"trace[709288235] transaction","detail":"{read_only:false; response_revision:8668; number_of_response:1; }","duration":"295.568741ms","start":"2026-09-02T16:43:15.082221Z","end":"2026-09-02T16:43:15.37779Z","steps":["trace[709288235] 'process raft request'  (duration: 294.637273ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T16:43:15.386537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.358498ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"warn","ts":"2026-09-02T16:43:15.386543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.006573ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-09-02T16:43:15.386606Z","caller":"traceutil/trace.go:171","msg":"trace[1232656011] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8669; }","duration":"179.459221ms","start":"2026-09-02T16:43:15.207131Z","end":"2026-09-02T16:43:15.38659Z","steps":["trace[1232656011] 'agreement among raft nodes before linearized reading'  (duration: 179.298626ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T16:43:15.386602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.923981ms","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-09-02T16:43:15.386633Z","caller":"traceutil/trace.go:171","msg":"trace[1280434533] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8669; }","duration":"128.155877ms","start":"2026-09-02T16:43:15.258459Z","end":"2026-09-02T16:43:15.386614Z","steps":["trace[1280434533] 'agreement among raft nodes before linearized reading'  (duration: 127.89475ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T16:43:15.386663Z","caller":"traceutil/trace.go:171","msg":"trace[1885246111] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8669; }","duration":"128.036123ms","start":"2026-09-02T16:43:15.258614Z","end":"2026-09-02T16:43:15.38665Z","steps":["trace[1885246111] 'agreement among raft nodes before linearized reading'  (duration: 127.859658ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T16:43:15.386735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.249292ms","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-09-02T16:43:15.386765Z","caller":"traceutil/trace.go:171","msg":"trace[1752260417] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8669; }","duration":"133.313005ms","start":"2026-09-02T16:43:15.253442Z","end":"2026-09-02T16:43:15.386755Z","steps":["trace[1752260417] 'agreement among raft nodes before linearized reading'  (duration: 132.903102ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T16:43:46.943205Z","caller":"traceutil/trace.go:171","msg":"trace[1706980560] transaction","detail":"{read_only:false; response_revision:8894; number_of_response:1; }","duration":"103.029715ms","start":"2026-09-02T16:43:46.840149Z","end":"2026-09-02T16:43:46.943179Z","steps":["trace[1706980560] 'process raft request'  (duration: 98.59887ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T16:43:54.970993Z","caller":"traceutil/trace.go:171","msg":"trace[1168568567] linearizableReadLoop","detail":"{readStateIndex:9256; appliedIndex:9255; }","duration":"108.401928ms","start":"2026-09-02T16:43:54.862569Z","end":"2026-09-02T16:43:54.970971Z","steps":["trace[1168568567] 'read index received'  (duration: 108.204302ms)","trace[1168568567] 'applied index is now lower than readState.Index'  (duration: 196.726µs)"],"step_count":2}
{"level":"info","ts":"2026-09-02T16:43:54.971096Z","caller":"traceutil/trace.go:171","msg":"trace[443161590] transaction","detail":"{read_only:false; response_revision:8935; number_of_response:1; }","duration":"245.135962ms","start":"2026-09-02T16:43:54.72593Z","end":"2026-09-02T16:43:54.971066Z","steps":["trace[443161590] 'process raft request'  (duration: 244.912725ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T16:43:54.97118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.596325ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" ","response":"range_response_count:1 size:1988"}
{"level":"info","ts":"2026-09-02T16:43:54.971211Z","caller":"traceutil/trace.go:171","msg":"trace[1223178691] range","detail":"{range_begin:/registry/services/specs/ingress-nginx/ingress-nginx-controller; range_end:; response_count:1; response_revision:8935; }","duration":"108.671986ms","start":"2026-09-02T16:43:54.862529Z","end":"2026-09-02T16:43:54.971201Z","steps":["trace[1223178691] 'agreement among raft nodes before linearized reading'  (duration: 108.525962ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T16:44:05.693424Z","caller":"traceutil/trace.go:171","msg":"trace[1155732953] transaction","detail":"{read_only:false; number_of_response:1; response_revision:9030; }","duration":"138.90925ms","start":"2026-09-02T16:44:05.554492Z","end":"2026-09-02T16:44:05.693401Z","steps":["trace[1155732953] 'process raft request'  (duration: 138.684373ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T16:44:05.693789Z","caller":"traceutil/trace.go:171","msg":"trace[438954721] transaction","detail":"{read_only:false; response_revision:9031; number_of_response:1; }","duration":"103.069867ms","start":"2026-09-02T16:44:05.59069Z","end":"2026-09-02T16:44:05.69376Z","steps":["trace[438954721] 'process raft request'  (duration: 102.651273ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T16:44:05.693846Z","caller":"traceutil/trace.go:171","msg":"trace[2091104744] linearizableReadLoop","detail":"{readStateIndex:9357; appliedIndex:9355; }","duration":"101.994083ms","start":"2026-09-02T16:44:05.591823Z","end":"2026-09-02T16:44:05.693818Z","steps":["trace[2091104744] 'read index received'  (duration: 15.035839ms)","trace[2091104744] 'applied index is now lower than readState.Index'  (duration: 86.956864ms)"],"step_count":2}
{"level":"info","ts":"2026-09-02T16:44:05.693933Z","caller":"traceutil/trace.go:171","msg":"trace[1604143803] transaction","detail":"{read_only:false; response_revision:9032; number_of_response:1; }","duration":"101.817808ms","start":"2026-09-02T16:44:05.59209Z","end":"2026-09-02T16:44:05.693907Z","steps":["trace[1604143803] 'process raft request'  (duration: 101.603532ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T16:44:05.69412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.280542ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-fhcc4\" ","response":"range_response_count:1 size:4647"}
{"level":"info","ts":"2026-09-02T16:44:05.694165Z","caller":"traceutil/trace.go:171","msg":"trace[1561019776] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-fhcc4; range_end:; response_count:1; response_revision:9032; }","duration":"102.346484ms","start":"2026-09-02T16:44:05.591808Z","end":"2026-09-02T16:44:05.694154Z","steps":["trace[1561019776] 'agreement among raft nodes before linearized reading'  (duration: 102.18969ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T16:44:07.162797Z","caller":"traceutil/trace.go:171","msg":"trace[2105342691] linearizableReadLoop","detail":"{readStateIndex:9373; appliedIndex:9372; }","duration":"100.499918ms","start":"2026-09-02T16:44:07.062266Z","end":"2026-09-02T16:44:07.162766Z","steps":["trace[2105342691] 'read index received'  (duration: 89.249034ms)","trace[2105342691] 'applied index is now lower than readState.Index'  (duration: 11.249704ms)"],"step_count":2}
{"level":"info","ts":"2026-09-02T16:44:07.162844Z","caller":"traceutil/trace.go:171","msg":"trace[1171522981] transaction","detail":"{read_only:false; response_revision:9046; number_of_response:1; }","duration":"115.180406ms","start":"2026-09-02T16:44:07.047629Z","end":"2026-09-02T16:44:07.162809Z","steps":["trace[1171522981] 'process raft request'  (duration: 104.021235ms)","trace[1171522981] 'compare'  (duration: 10.937314ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-02T16:44:07.162944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.657583ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/openstack/rook-ceph-config\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-02T16:44:07.163009Z","caller":"traceutil/trace.go:171","msg":"trace[877708685] range","detail":"{range_begin:/registry/secrets/openstack/rook-ceph-config; range_end:; response_count:0; response_revision:9046; }","duration":"100.759375ms","start":"2026-09-02T16:44:07.062235Z","end":"2026-09-02T16:44:07.162994Z","steps":["trace[877708685] 'agreement among raft nodes before linearized reading'  (duration: 100.638252ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T16:45:06.197103Z","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-09-02T16:45:06.207102Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-09-02T16:45:06.207218Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-09-02T16:46:52.990501Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8030}
{"level":"info","ts":"2026-09-02T16:46:53.066045Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8030,"took":"73.382746ms","hash":4212223030,"current-db-size-bytes":57520128,"current-db-size":"58 MB","current-db-size-in-use-bytes":27799552,"current-db-size-in-use":"28 MB"}
{"level":"info","ts":"2026-09-02T16:46:53.066128Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4212223030,"revision":8030,"compact-revision":5849}
{"level":"info","ts":"2026-09-02T16:51:04.256483Z","caller":"traceutil/trace.go:171","msg":"trace[1335240314] linearizableReadLoop","detail":"{readStateIndex:12658; appliedIndex:12657; }","duration":"255.396516ms","start":"2026-09-02T16:51:04.001054Z","end":"2026-09-02T16:51:04.25645Z","steps":["trace[1335240314] 'read index received'  (duration: 166.98565ms)","trace[1335240314] 'applied index is now lower than readState.Index'  (duration: 88.409585ms)"],"step_count":2}
{"level":"info","ts":"2026-09-02T16:51:04.256599Z","caller":"traceutil/trace.go:171","msg":"trace[2069543360] transaction","detail":"{read_only:false; response_revision:12232; number_of_response:1; }","duration":"261.142891ms","start":"2026-09-02T16:51:03.99542Z","end":"2026-09-02T16:51:04.256562Z","steps":["trace[2069543360] 'process raft request'  (duration: 172.716755ms)","trace[2069543360] 'compare'  (duration: 88.129907ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-02T16:51:04.257009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.924841ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"warn","ts":"2026-09-02T16:51:04.257038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.03057ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"warn","ts":"2026-09-02T16:51:04.257045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.56748ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-02T16:51:04.25708Z","caller":"traceutil/trace.go:171","msg":"trace[586183349] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:12232; }","duration":"256.027785ms","start":"2026-09-02T16:51:04.001035Z","end":"2026-09-02T16:51:04.257063Z","steps":["trace[586183349] 'agreement among raft nodes before linearized reading'  (duration: 255.680044ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T16:51:04.25711Z","caller":"traceutil/trace.go:171","msg":"trace[681839714] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:12232; }","duration":"171.651784ms","start":"2026-09-02T16:51:04.085438Z","end":"2026-09-02T16:51:04.25709Z","steps":["trace[681839714] 'agreement among raft nodes before linearized reading'  (duration: 171.546929ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T16:51:04.257123Z","caller":"traceutil/trace.go:171","msg":"trace[1289540841] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:12232; }","duration":"247.153555ms","start":"2026-09-02T16:51:04.009929Z","end":"2026-09-02T16:51:04.257083Z","steps":["trace[1289540841] 'agreement among raft nodes before linearized reading'  (duration: 246.972869ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T16:51:04.257128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.229535ms","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-09-02T16:51:04.257206Z","caller":"traceutil/trace.go:171","msg":"trace[317659705] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:12232; }","duration":"241.368329ms","start":"2026-09-02T16:51:04.015816Z","end":"2026-09-02T16:51:04.257184Z","steps":["trace[317659705] 'agreement among raft nodes before linearized reading'  (duration: 241.170573ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T16:51:04.257255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.327625ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12212"}
{"level":"info","ts":"2026-09-02T16:51:04.257409Z","caller":"traceutil/trace.go:171","msg":"trace[878690855] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:12232; }","duration":"195.621064ms","start":"2026-09-02T16:51:04.061712Z","end":"2026-09-02T16:51:04.257333Z","steps":["trace[878690855] 'agreement among raft nodes before linearized reading'  (duration: 195.259882ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T16:51:05.562992Z","caller":"traceutil/trace.go:171","msg":"trace[1650898372] transaction","detail":"{read_only:false; response_revision:12240; number_of_response:1; }","duration":"278.563172ms","start":"2026-09-02T16:51:05.284374Z","end":"2026-09-02T16:51:05.562937Z","steps":["trace[1650898372] 'process raft request'  (duration: 278.284033ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T16:51:05.578765Z","caller":"traceutil/trace.go:171","msg":"trace[842314758] linearizableReadLoop","detail":"{readStateIndex:12667; appliedIndex:12665; }","duration":"235.333435ms","start":"2026-09-02T16:51:05.343388Z","end":"2026-09-02T16:51:05.578722Z","steps":["trace[842314758] 'read index received'  (duration: 219.276295ms)","trace[842314758] 'applied index is now lower than readState.Index'  (duration: 16.055729ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-02T16:51:05.579009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.594673ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-ks-user\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-02T16:51:05.578889Z","caller":"traceutil/trace.go:171","msg":"trace[872942778] transaction","detail":"{read_only:false; response_revision:12241; number_of_response:1; }","duration":"291.758224ms","start":"2026-09-02T16:51:05.287096Z","end":"2026-09-02T16:51:05.578854Z","steps":["trace[872942778] 'process raft request'  (duration: 291.419623ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T16:51:05.579077Z","caller":"traceutil/trace.go:171","msg":"trace[827599136] range","detail":"{range_begin:/registry/jobs/openstack/cinder-ks-user; range_end:; response_count:0; response_revision:12241; }","duration":"235.719367ms","start":"2026-09-02T16:51:05.34334Z","end":"2026-09-02T16:51:05.579059Z","steps":["trace[827599136] 'agreement among raft nodes before linearized reading'  (duration: 235.583063ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T16:51:05.579262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.330599ms","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:7"}
{"level":"info","ts":"2026-09-02T16:51:05.579344Z","caller":"traceutil/trace.go:171","msg":"trace[1798408311] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:12241; }","duration":"100.451773ms","start":"2026-09-02T16:51:05.478873Z","end":"2026-09-02T16:51:05.579325Z","steps":["trace[1798408311] 'agreement among raft nodes before linearized reading'  (duration: 100.321279ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T16:51:05.579365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.332624ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-ks-endpoints\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-09-02T16:51:05.5794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.472398ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-storage-init\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-09-02T16:51:05.579269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.364115ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-rabbit-init\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-02T16:51:05.579422Z","caller":"traceutil/trace.go:171","msg":"trace[690915367] range","detail":"{range_begin:/registry/jobs/openstack/cinder-ks-endpoints; range_end:; response_count:0; response_revision:12241; }","duration":"235.434987ms","start":"2026-09-02T16:51:05.343972Z","end":"2026-09-02T16:51:05.579407Z","steps":["trace[690915367] 'agreement among raft nodes before linearized reading'  (duration: 235.349024ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T16:51:05.579432Z","caller":"traceutil/trace.go:171","msg":"trace[337160005] range","detail":"{range_begin:/registry/jobs/openstack/cinder-storage-init; range_end:; response_count:0; response_revision:12241; }","duration":"235.528269ms","start":"2026-09-02T16:51:05.343895Z","end":"2026-09-02T16:51:05.579423Z","steps":["trace[337160005] 'agreement among raft nodes before linearized reading'  (duration: 235.468428ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T16:51:05.579472Z","caller":"traceutil/trace.go:171","msg":"trace[459531853] range","detail":"{range_begin:/registry/jobs/openstack/cinder-rabbit-init; range_end:; response_count:0; response_revision:12241; }","duration":"235.587672ms","start":"2026-09-02T16:51:05.343854Z","end":"2026-09-02T16:51:05.579441Z","steps":["trace[459531853] 'agreement among raft nodes before linearized reading'  (duration: 235.336024ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T16:51:05.579967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.771775ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-db-sync\" ","response":"range_response_count:1 size:5077"}
{"level":"info","ts":"2026-09-02T16:51:05.580089Z","caller":"traceutil/trace.go:171","msg":"trace[2120092861] range","detail":"{range_begin:/registry/jobs/openstack/cinder-db-sync; range_end:; response_count:1; response_revision:12241; }","duration":"230.943261ms","start":"2026-09-02T16:51:05.349127Z","end":"2026-09-02T16:51:05.58007Z","steps":["trace[2120092861] 'agreement among raft nodes before linearized reading'  (duration: 230.185508ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T16:51:39.09973Z","caller":"traceutil/trace.go:171","msg":"trace[1721616049] transaction","detail":"{read_only:false; response_revision:12473; number_of_response:1; }","duration":"206.209586ms","start":"2026-09-02T16:51:38.893497Z","end":"2026-09-02T16:51:39.099706Z","steps":["trace[1721616049] 'process raft request'  (duration: 205.867626ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T16:51:40.717047Z","caller":"traceutil/trace.go:171","msg":"trace[1011157777] linearizableReadLoop","detail":"{readStateIndex:12915; appliedIndex:12913; }","duration":"175.641365ms","start":"2026-09-02T16:51:40.541383Z","end":"2026-09-02T16:51:40.717024Z","steps":["trace[1011157777] 'read index received'  (duration: 149.246271ms)","trace[1011157777] 'applied index is now lower than readState.Index'  (duration: 26.394054ms)"],"step_count":2}
{"level":"info","ts":"2026-09-02T16:51:40.717108Z","caller":"traceutil/trace.go:171","msg":"trace[1397985445] transaction","detail":"{read_only:false; response_revision:12480; number_of_response:1; }","duration":"181.241106ms","start":"2026-09-02T16:51:40.535833Z","end":"2026-09-02T16:51:40.717074Z","steps":["trace[1397985445] 'process raft request'  (duration: 154.725417ms)","trace[1397985445] 'compare'  (duration: 26.26522ms)"],"step_count":2}
{"level":"info","ts":"2026-09-02T16:51:40.717306Z","caller":"traceutil/trace.go:171","msg":"trace[1452424204] transaction","detail":"{read_only:false; response_revision:12481; number_of_response:1; }","duration":"179.797842ms","start":"2026-09-02T16:51:40.537495Z","end":"2026-09-02T16:51:40.717293Z","steps":["trace[1452424204] 'process raft request'  (duration: 179.480933ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T16:51:40.717455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.048177ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"}
{"level":"info","ts":"2026-09-02T16:51:40.717536Z","caller":"traceutil/trace.go:171","msg":"trace[1210400620] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:12481; }","duration":"176.13611ms","start":"2026-09-02T16:51:40.541375Z","end":"2026-09-02T16:51:40.717511Z","steps":["trace[1210400620] 'agreement among raft nodes before linearized reading'  (duration: 175.843391ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T16:51:45.859824Z","caller":"traceutil/trace.go:171","msg":"trace[1797164054] transaction","detail":"{read_only:false; response_revision:12524; number_of_response:1; }","duration":"113.060507ms","start":"2026-09-02T16:51:45.746713Z","end":"2026-09-02T16:51:45.859774Z","steps":["trace[1797164054] 'process raft request'  (duration: 112.673945ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T16:51:48.014274Z","caller":"traceutil/trace.go:171","msg":"trace[2038920021] transaction","detail":"{read_only:false; response_revision:12545; number_of_response:1; }","duration":"112.039155ms","start":"2026-09-02T16:51:47.902207Z","end":"2026-09-02T16:51:48.014246Z","steps":["trace[2038920021] 'process raft request'  (duration: 98.710899ms)","trace[2038920021] 'compare'  (duration: 13.177182ms)"],"step_count":2}
{"level":"info","ts":"2026-09-02T16:51:53.01952Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10392}
{"level":"info","ts":"2026-09-02T16:51:53.121594Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10392,"took":"99.824193ms","hash":3387678876,"current-db-size-bytes":57520128,"current-db-size":"58 MB","current-db-size-in-use-bytes":26226688,"current-db-size-in-use":"26 MB"}
{"level":"info","ts":"2026-09-02T16:51:53.121668Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3387678876,"revision":10392,"compact-revision":8030}
{"level":"info","ts":"2026-09-02T16:56:53.061487Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12577}
{"level":"info","ts":"2026-09-02T16:56:53.160801Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12577,"took":"96.345148ms","hash":4161293183,"current-db-size-bytes":57520128,"current-db-size":"58 MB","current-db-size-in-use-bytes":27840512,"current-db-size-in-use":"28 MB"}
{"level":"info","ts":"2026-09-02T16:56:53.16087Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4161293183,"revision":12577,"compact-revision":10392}
{"level":"warn","ts":"2026-09-02T16:57:14.471766Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.013782ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16594533598801615841 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/poddisruptionbudgets/openstack/placement-api\" mod_revision:13963 > success:<request_put:<key:\"/registry/poddisruptionbudgets/openstack/placement-api\" value_size:1045 >> failure:<request_range:<key:\"/registry/poddisruptionbudgets/openstack/placement-api\" > >>","response":"size:16"}
{"level":"info","ts":"2026-09-02T16:57:14.4719Z","caller":"traceutil/trace.go:171","msg":"trace[979125423] transaction","detail":"{read_only:false; response_revision:14728; number_of_response:1; }","duration":"193.463979ms","start":"2026-09-02T16:57:14.278416Z","end":"2026-09-02T16:57:14.47188Z","steps":["trace[979125423] 'process raft request'  (duration: 68.19948ms)","trace[979125423] 'compare'  (duration: 124.861527ms)"],"step_count":2}
{"level":"info","ts":"2026-09-02T16:57:14.473125Z","caller":"traceutil/trace.go:171","msg":"trace[1989101427] transaction","detail":"{read_only:false; response_revision:14729; number_of_response:1; }","duration":"191.027156ms","start":"2026-09-02T16:57:14.282069Z","end":"2026-09-02T16:57:14.473096Z","steps":["trace[1989101427] 'process raft request'  (duration: 190.802549ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T16:57:14.473151Z","caller":"traceutil/trace.go:171","msg":"trace[59715316] transaction","detail":"{read_only:false; response_revision:14730; number_of_response:1; }","duration":"190.734197ms","start":"2026-09-02T16:57:14.282392Z","end":"2026-09-02T16:57:14.473126Z","steps":["trace[59715316] 'process raft request'  (duration: 190.629353ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T16:57:14.473564Z","caller":"traceutil/trace.go:171","msg":"trace[1157568136] transaction","detail":"{read_only:false; response_revision:14731; number_of_response:1; }","duration":"189.932103ms","start":"2026-09-02T16:57:14.283591Z","end":"2026-09-02T16:57:14.473523Z","steps":["trace[1157568136] 'process raft request'  (duration: 189.482669ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T16:57:39.480116Z","caller":"traceutil/trace.go:171","msg":"trace[2042058776] linearizableReadLoop","detail":"{readStateIndex:15381; appliedIndex:15380; }","duration":"153.990496ms","start":"2026-09-02T16:57:39.326102Z","end":"2026-09-02T16:57:39.480093Z","steps":["trace[2042058776] 'read index received'  (duration: 153.80382ms)","trace[2042058776] 'applied index is now lower than readState.Index'  (duration: 185.306µs)"],"step_count":2}
{"level":"info","ts":"2026-09-02T16:57:39.4802Z","caller":"traceutil/trace.go:171","msg":"trace[267320611] transaction","detail":"{read_only:false; response_revision:14862; number_of_response:1; }","duration":"193.105369ms","start":"2026-09-02T16:57:39.287051Z","end":"2026-09-02T16:57:39.480156Z","steps":["trace[267320611] 'process raft request'  (duration: 192.859801ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T16:57:39.480386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.249604ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:1853"}
{"level":"info","ts":"2026-09-02T16:57:39.480421Z","caller":"traceutil/trace.go:171","msg":"trace[1492755422] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:14862; }","duration":"154.371558ms","start":"2026-09-02T16:57:39.32604Z","end":"2026-09-02T16:57:39.480412Z","steps":["trace[1492755422] 'agreement among raft nodes before linearized reading'  (duration: 154.147831ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T16:57:39.621016Z","caller":"traceutil/trace.go:171","msg":"trace[492630135] linearizableReadLoop","detail":"{readStateIndex:15382; appliedIndex:15381; }","duration":"136.818163ms","start":"2026-09-02T16:57:39.48413Z","end":"2026-09-02T16:57:39.620948Z","steps":["trace[492630135] 'read index received'  (duration: 132.264364ms)","trace[492630135] 'applied index is now lower than readState.Index'  (duration: 4.552259ms)"],"step_count":2}
{"level":"info","ts":"2026-09-02T16:57:39.621052Z","caller":"traceutil/trace.go:171","msg":"trace[728879608] transaction","detail":"{read_only:false; response_revision:14863; number_of_response:1; }","duration":"160.633889ms","start":"2026-09-02T16:57:39.460377Z","end":"2026-09-02T16:57:39.621011Z","steps":["trace[728879608] 'process raft request'  (duration: 156.027099ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T16:57:39.621208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.06479ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-9dbbd2dd-9530-4445-bfb9-abfd155bda89\" ","response":"range_response_count:1 size:1303"}
{"level":"info","ts":"2026-09-02T16:57:39.621285Z","caller":"traceutil/trace.go:171","msg":"trace[8986974] range","detail":"{range_begin:/registry/persistentvolumes/pvc-9dbbd2dd-9530-4445-bfb9-abfd155bda89; range_end:; response_count:1; response_revision:14863; }","duration":"137.185573ms","start":"2026-09-02T16:57:39.484067Z","end":"2026-09-02T16:57:39.621252Z","steps":["trace[8986974] 'agreement among raft nodes before linearized reading'  (duration: 136.999817ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T16:57:48.994208Z","caller":"traceutil/trace.go:171","msg":"trace[853670933] linearizableReadLoop","detail":"{readStateIndex:15430; appliedIndex:15429; }","duration":"113.10965ms","start":"2026-09-02T16:57:48.881076Z","end":"2026-09-02T16:57:48.994186Z","steps":["trace[853670933] 'read index received'  (duration: 112.949314ms)","trace[853670933] 'applied index is now lower than readState.Index'  (duration: 159.306µs)"],"step_count":2}
{"level":"info","ts":"2026-09-02T16:57:48.994263Z","caller":"traceutil/trace.go:171","msg":"trace[807778575] transaction","detail":"{read_only:false; response_revision:14909; number_of_response:1; }","duration":"123.031442ms","start":"2026-09-02T16:57:48.871206Z","end":"2026-09-02T16:57:48.994237Z","steps":["trace[807778575] 'process raft request'  (duration: 122.833445ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T16:57:48.994448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.345617ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"}
{"level":"info","ts":"2026-09-02T16:57:48.994543Z","caller":"traceutil/trace.go:171","msg":"trace[1696175813] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:14909; }","duration":"113.46596ms","start":"2026-09-02T16:57:48.881051Z","end":"2026-09-02T16:57:48.994516Z","steps":["trace[1696175813] 'agreement among raft nodes before linearized reading'  (duration: 113.235993ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T16:57:58.207433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.320523ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16594533598801616517 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:14945 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >>","response":"size:16"}
{"level":"info","ts":"2026-09-02T16:57:58.207594Z","caller":"traceutil/trace.go:171","msg":"trace[334732507] transaction","detail":"{read_only:false; response_revision:14974; number_of_response:1; }","duration":"503.824846ms","start":"2026-09-02T16:57:57.703699Z","end":"2026-09-02T16:57:58.207524Z","steps":["trace[334732507] 'process raft request'  (duration: 216.331899ms)","trace[334732507] 'compare'  (duration: 287.229829ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-02T16:57:58.207708Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T16:57:57.703675Z","time spent":"503.956279ms","remote":"127.0.0.1:51094","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:14945 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-09-02T16:58:22.475865Z","caller":"traceutil/trace.go:171","msg":"trace[532335004] transaction","detail":"{read_only:false; response_revision:15293; number_of_response:1; }","duration":"198.356789ms","start":"2026-09-02T16:58:22.277475Z","end":"2026-09-02T16:58:22.475832Z","steps":["trace[532335004] 'process raft request'  (duration: 198.180223ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T16:58:22.568078Z","caller":"traceutil/trace.go:171","msg":"trace[1728885724] linearizableReadLoop","detail":"{readStateIndex:15832; appliedIndex:15830; }","duration":"186.444416ms","start":"2026-09-02T16:58:22.381607Z","end":"2026-09-02T16:58:22.568051Z","steps":["trace[1728885724] 'read index received'  (duration: 94.11285ms)","trace[1728885724] 'applied index is now lower than readState.Index'  (duration: 92.329996ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-02T16:58:22.568288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.667213ms","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-09-02T16:58:22.568343Z","caller":"traceutil/trace.go:171","msg":"trace[1382685024] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:15294; }","duration":"186.755346ms","start":"2026-09-02T16:58:22.381559Z","end":"2026-09-02T16:58:22.568314Z","steps":["trace[1382685024] 'agreement among raft nodes before linearized reading'  (duration: 186.58724ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T16:58:22.568383Z","caller":"traceutil/trace.go:171","msg":"trace[1868035353] transaction","detail":"{read_only:false; response_revision:15294; number_of_response:1; }","duration":"267.608562ms","start":"2026-09-02T16:58:22.300752Z","end":"2026-09-02T16:58:22.568361Z","steps":["trace[1868035353] 'process raft request'  (duration: 265.049074ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T16:59:19.069655Z","caller":"traceutil/trace.go:171","msg":"trace[1746084861] transaction","detail":"{read_only:false; response_revision:15947; number_of_response:1; }","duration":"121.180618ms","start":"2026-09-02T16:59:18.948455Z","end":"2026-09-02T16:59:19.069636Z","steps":["trace[1746084861] 'process raft request'  (duration: 73.347338ms)","trace[1746084861] 'compare'  (duration: 47.761118ms)"],"step_count":2}
{"level":"info","ts":"2026-09-02T16:59:53.049604Z","caller":"traceutil/trace.go:171","msg":"trace[226362687] transaction","detail":"{read_only:false; response_revision:16125; number_of_response:1; }","duration":"123.380175ms","start":"2026-09-02T16:59:52.926198Z","end":"2026-09-02T16:59:53.049578Z","steps":["trace[226362687] 'process raft request'  (duration: 123.167969ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T16:59:53.049793Z","caller":"traceutil/trace.go:171","msg":"trace[1106607608] transaction","detail":"{read_only:false; response_revision:16126; number_of_response:1; }","duration":"123.561781ms","start":"2026-09-02T16:59:52.9262Z","end":"2026-09-02T16:59:53.049762Z","steps":["trace[1106607608] 'process raft request'  (duration: 123.341274ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T16:59:53.330639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.024848ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16594533598801620314 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:16117 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:16"}
{"level":"info","ts":"2026-09-02T16:59:53.330744Z","caller":"traceutil/trace.go:171","msg":"trace[849414609] linearizableReadLoop","detail":"{readStateIndex:16689; appliedIndex:16688; }","duration":"262.047858ms","start":"2026-09-02T16:59:53.068681Z","end":"2026-09-02T16:59:53.330729Z","steps":["trace[849414609] 'read index received'  (duration: 114.794943ms)","trace[849414609] 'applied index is now lower than readState.Index'  (duration: 147.233694ms)"],"step_count":2}
{"level":"info","ts":"2026-09-02T16:59:53.330748Z","caller":"traceutil/trace.go:171","msg":"trace[925254058] transaction","detail":"{read_only:false; response_revision:16127; number_of_response:1; }","duration":"263.366038ms","start":"2026-09-02T16:59:53.067351Z","end":"2026-09-02T16:59:53.330717Z","steps":["trace[925254058] 'process raft request'  (duration: 116.192956ms)","trace[925254058] 'compare'  (duration: 146.639957ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-02T16:59:53.331619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.942506ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:76 size:737231"}
{"level":"info","ts":"2026-09-02T16:59:53.33167Z","caller":"traceutil/trace.go:171","msg":"trace[159711269] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:76; response_revision:16127; }","duration":"263.022327ms","start":"2026-09-02T16:59:53.068637Z","end":"2026-09-02T16:59:53.331659Z","steps":["trace[159711269] 'agreement among raft nodes before linearized reading'  (duration: 262.150731ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T16:59:53.418654Z","caller":"traceutil/trace.go:171","msg":"trace[1117005325] transaction","detail":"{read_only:false; response_revision:16128; number_of_response:1; }","duration":"215.528929ms","start":"2026-09-02T16:59:53.203097Z","end":"2026-09-02T16:59:53.418626Z","steps":["trace[1117005325] 'process raft request'  (duration: 215.352383ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T16:59:53.419091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.463864ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-swxs7\" ","response":"range_response_count:1 size:22096"}
{"level":"info","ts":"2026-09-02T16:59:53.419183Z","caller":"traceutil/trace.go:171","msg":"trace[733488895] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-swxs7; range_end:; response_count:1; response_revision:16128; }","duration":"152.600828ms","start":"2026-09-02T16:59:53.266561Z","end":"2026-09-02T16:59:53.419162Z","steps":["trace[733488895] 'agreement among raft nodes before linearized reading'  (duration: 152.34011ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T16:59:53.41922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"333.380326ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-02T16:59:53.419302Z","caller":"traceutil/trace.go:171","msg":"trace[957910011] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:16128; }","duration":"333.489778ms","start":"2026-09-02T16:59:53.08579Z","end":"2026-09-02T16:59:53.419279Z","steps":["trace[957910011] 'agreement among raft nodes before linearized reading'  (duration: 333.340524ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T16:59:53.419304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.941995ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"}
{"level":"warn","ts":"2026-09-02T16:59:53.419347Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T16:59:53.085779Z","time spent":"333.556001ms","remote":"127.0.0.1:50810","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-09-02T16:59:53.41935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.311546ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-swxs7\" ","response":"range_response_count:1 size:22096"}
{"level":"info","ts":"2026-09-02T16:59:53.419391Z","caller":"traceutil/trace.go:171","msg":"trace[1516141927] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-swxs7; range_end:; response_count:1; response_revision:16128; }","duration":"242.380538ms","start":"2026-09-02T16:59:53.176999Z","end":"2026-09-02T16:59:53.41938Z","steps":["trace[1516141927] 'agreement among raft nodes before linearized reading'  (duration: 241.891154ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T16:59:53.419389Z","caller":"traceutil/trace.go:171","msg":"trace[767173614] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:16128; }","duration":"109.122661ms","start":"2026-09-02T16:59:53.310247Z","end":"2026-09-02T16:59:53.41937Z","steps":["trace[767173614] 'agreement among raft nodes before linearized reading'  (duration: 108.867713ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T16:59:53.565067Z","caller":"traceutil/trace.go:171","msg":"trace[1626088277] transaction","detail":"{read_only:false; response_revision:16129; number_of_response:1; }","duration":"141.175409ms","start":"2026-09-02T16:59:53.423865Z","end":"2026-09-02T16:59:53.565041Z","steps":["trace[1626088277] 'process raft request'  (duration: 130.421582ms)","trace[1626088277] 'compare'  (duration: 10.495649ms)"],"step_count":2}
{"level":"info","ts":"2026-09-02T16:59:53.56714Z","caller":"traceutil/trace.go:171","msg":"trace[1191184940] linearizableReadLoop","detail":"{readStateIndex:16692; appliedIndex:16690; }","duration":"139.130097ms","start":"2026-09-02T16:59:53.427989Z","end":"2026-09-02T16:59:53.567119Z","steps":["trace[1191184940] 'read index received'  (duration: 126.375108ms)","trace[1191184940] 'applied index is now lower than readState.Index'  (duration: 12.754259ms)"],"step_count":2}
{"level":"info","ts":"2026-09-02T16:59:53.567197Z","caller":"traceutil/trace.go:171","msg":"trace[1632059897] transaction","detail":"{read_only:false; response_revision:16130; number_of_response:1; }","duration":"141.549681ms","start":"2026-09-02T16:59:53.425627Z","end":"2026-09-02T16:59:53.567177Z","steps":["trace[1632059897] 'process raft request'  (duration: 141.375836ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T16:59:53.567953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.222758ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:76 size:737231"}
{"level":"info","ts":"2026-09-02T16:59:53.567995Z","caller":"traceutil/trace.go:171","msg":"trace[2062499323] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:76; response_revision:16130; }","duration":"137.304151ms","start":"2026-09-02T16:59:53.43068Z","end":"2026-09-02T16:59:53.567984Z","steps":["trace[2062499323] 'agreement among raft nodes before linearized reading'  (duration: 136.551498ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T16:59:53.568935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.909791ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:76 size:737231"}
{"level":"info","ts":"2026-09-02T16:59:53.569025Z","caller":"traceutil/trace.go:171","msg":"trace[324514956] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:76; response_revision:16130; }","duration":"141.019704ms","start":"2026-09-02T16:59:53.427985Z","end":"2026-09-02T16:59:53.569004Z","steps":["trace[324514956] 'agreement among raft nodes before linearized reading'  (duration: 139.25009ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T16:59:53.769139Z","caller":"traceutil/trace.go:171","msg":"trace[1994460646] transaction","detail":"{read_only:false; response_revision:16131; number_of_response:1; }","duration":"100.458767ms","start":"2026-09-02T16:59:53.668657Z","end":"2026-09-02T16:59:53.769116Z","steps":["trace[1994460646] 'process raft request'  (duration: 50.321027ms)","trace[1994460646] 'compare'  (duration: 49.898543ms)"],"step_count":2}
{"level":"info","ts":"2026-09-02T16:59:59.211345Z","caller":"traceutil/trace.go:171","msg":"trace[1857927558] transaction","detail":"{read_only:false; response_revision:16156; number_of_response:1; }","duration":"120.673513ms","start":"2026-09-02T16:59:59.090646Z","end":"2026-09-02T16:59:59.211319Z","steps":["trace[1857927558] 'process raft request'  (duration: 120.54925ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T17:01:53.070653Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14577}
{"level":"info","ts":"2026-09-02T17:01:53.187012Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14577,"took":"113.3494ms","hash":3079713472,"current-db-size-bytes":57520128,"current-db-size":"58 MB","current-db-size-in-use-bytes":31121408,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-09-02T17:01:53.187084Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3079713472,"revision":14577,"compact-revision":12577}
{"level":"warn","ts":"2026-09-02T17:03:49.352649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.627072ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/neutron-server\" ","response":"range_response_count:1 size:703"}
{"level":"info","ts":"2026-09-02T17:03:49.352711Z","caller":"traceutil/trace.go:171","msg":"trace[1348438856] range","detail":"{range_begin:/registry/services/endpoints/openstack/neutron-server; range_end:; response_count:1; response_revision:17955; }","duration":"103.731975ms","start":"2026-09-02T17:03:49.248962Z","end":"2026-09-02T17:03:49.352694Z","steps":["trace[1348438856] 'range keys from in-memory index tree'  (duration: 103.498369ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T17:03:49.37696Z","caller":"traceutil/trace.go:171","msg":"trace[1182393084] transaction","detail":"{read_only:false; response_revision:17956; number_of_response:1; }","duration":"127.106438ms","start":"2026-09-02T17:03:49.24983Z","end":"2026-09-02T17:03:49.376937Z","steps":["trace[1182393084] 'process raft request'  (duration: 126.927853ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T17:06:43.97038Z","caller":"traceutil/trace.go:171","msg":"trace[681838640] linearizableReadLoop","detail":"{readStateIndex:19774; appliedIndex:19773; }","duration":"121.025895ms","start":"2026-09-02T17:06:43.849331Z","end":"2026-09-02T17:06:43.970357Z","steps":["trace[681838640] 'read index received'  (duration: 120.832089ms)","trace[681838640] 'applied index is now lower than readState.Index'  (duration: 192.826µs)"],"step_count":2}
{"level":"info","ts":"2026-09-02T17:06:43.970497Z","caller":"traceutil/trace.go:171","msg":"trace[899777164] transaction","detail":"{read_only:false; response_revision:19111; number_of_response:1; }","duration":"158.640332ms","start":"2026-09-02T17:06:43.811814Z","end":"2026-09-02T17:06:43.970454Z","steps":["trace[899777164] 'process raft request'  (duration: 158.398855ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T17:06:43.970595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.257061ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/neutron-dhcp-agent-default-j9qrb\" ","response":"range_response_count:1 size:18870"}
{"level":"info","ts":"2026-09-02T17:06:43.970643Z","caller":"traceutil/trace.go:171","msg":"trace[604253518] range","detail":"{range_begin:/registry/pods/openstack/neutron-dhcp-agent-default-j9qrb; range_end:; response_count:1; response_revision:19111; }","duration":"121.373235ms","start":"2026-09-02T17:06:43.849258Z","end":"2026-09-02T17:06:43.970631Z","steps":["trace[604253518] 'agreement among raft nodes before linearized reading'  (duration: 121.21974ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T17:06:50.970295Z","caller":"traceutil/trace.go:171","msg":"trace[691231088] transaction","detail":"{read_only:false; response_revision:19150; number_of_response:1; }","duration":"187.753431ms","start":"2026-09-02T17:06:50.782506Z","end":"2026-09-02T17:06:50.970259Z","steps":["trace[691231088] 'process raft request'  (duration: 187.589626ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T17:06:51.054461Z","caller":"traceutil/trace.go:171","msg":"trace[856043543] transaction","detail":"{read_only:false; response_revision:19151; number_of_response:1; }","duration":"183.198532ms","start":"2026-09-02T17:06:50.871244Z","end":"2026-09-02T17:06:51.054443Z","steps":["trace[856043543] 'process raft request'  (duration: 183.031127ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T17:06:51.461848Z","caller":"traceutil/trace.go:171","msg":"trace[446499766] linearizableReadLoop","detail":"{readStateIndex:19818; appliedIndex:19817; }","duration":"238.052985ms","start":"2026-09-02T17:06:51.223772Z","end":"2026-09-02T17:06:51.461825Z","steps":["trace[446499766] 'read index received'  (duration: 237.813538ms)","trace[446499766] 'applied index is now lower than readState.Index'  (duration: 238.537µs)"],"step_count":2}
{"level":"info","ts":"2026-09-02T17:06:51.462069Z","caller":"traceutil/trace.go:171","msg":"trace[1501234510] transaction","detail":"{read_only:false; response_revision:19154; number_of_response:1; }","duration":"244.537613ms","start":"2026-09-02T17:06:51.217496Z","end":"2026-09-02T17:06:51.462034Z","steps":["trace[1501234510] 'process raft request'  (duration: 244.156071ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T17:06:51.463465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.681875ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:97 size:969176"}
{"level":"info","ts":"2026-09-02T17:06:51.463576Z","caller":"traceutil/trace.go:171","msg":"trace[1884401316] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:97; response_revision:19154; }","duration":"239.808149ms","start":"2026-09-02T17:06:51.223754Z","end":"2026-09-02T17:06:51.463562Z","steps":["trace[1884401316] 'agreement among raft nodes before linearized reading'  (duration: 238.263522ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T17:06:51.892566Z","caller":"traceutil/trace.go:171","msg":"trace[133210015] transaction","detail":"{read_only:false; response_revision:19155; number_of_response:1; }","duration":"305.208926ms","start":"2026-09-02T17:06:51.587328Z","end":"2026-09-02T17:06:51.892536Z","steps":["trace[133210015] 'process raft request'  (duration: 305.01827ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T17:06:51.892939Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T17:06:51.587299Z","time spent":"305.35423ms","remote":"127.0.0.1:51094","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:19140 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-09-02T17:06:52.223211Z","caller":"traceutil/trace.go:171","msg":"trace[1056604254] transaction","detail":"{read_only:false; response_revision:19156; number_of_response:1; }","duration":"517.351651ms","start":"2026-09-02T17:06:51.705817Z","end":"2026-09-02T17:06:52.223169Z","steps":["trace[1056604254] 'process raft request'  (duration: 516.66886ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T17:06:52.223555Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T17:06:51.705792Z","time spent":"517.517696ms","remote":"127.0.0.1:51094","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:19141 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"info","ts":"2026-09-02T17:06:52.259278Z","caller":"traceutil/trace.go:171","msg":"trace[994956312] linearizableReadLoop","detail":"{readStateIndex:19821; appliedIndex:19819; }","duration":"246.831334ms","start":"2026-09-02T17:06:52.012412Z","end":"2026-09-02T17:06:52.259244Z","steps":["trace[994956312] 'read index received'  (duration: 209.973899ms)","trace[994956312] 'applied index is now lower than readState.Index'  (duration: 36.855555ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-02T17:06:52.259628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.239699ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/superstreams/\" range_end:\"/registry/rabbitmq.com/superstreams0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-02T17:06:52.2597Z","caller":"traceutil/trace.go:171","msg":"trace[1346738622] range","detail":"{range_begin:/registry/rabbitmq.com/superstreams/; range_end:/registry/rabbitmq.com/superstreams0; response_count:0; response_revision:19156; }","duration":"234.373083ms","start":"2026-09-02T17:06:52.025308Z","end":"2026-09-02T17:06:52.259681Z","steps":["trace[1346738622] 'agreement among raft nodes before linearized reading'  (duration: 234.229549ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T17:06:52.25976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.314399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"}
{"level":"info","ts":"2026-09-02T17:06:52.259821Z","caller":"traceutil/trace.go:171","msg":"trace[1822732186] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:19156; }","duration":"247.431192ms","start":"2026-09-02T17:06:52.012375Z","end":"2026-09-02T17:06:52.259806Z","steps":["trace[1822732186] 'agreement among raft nodes before linearized reading'  (duration: 247.208495ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T17:06:52.259697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.458718ms","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-09-02T17:06:52.259966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.489975ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-02T17:06:52.260005Z","caller":"traceutil/trace.go:171","msg":"trace[1447552926] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:19156; }","duration":"174.571978ms","start":"2026-09-02T17:06:52.085423Z","end":"2026-09-02T17:06:52.259995Z","steps":["trace[1447552926] 'agreement among raft nodes before linearized reading'  (duration: 174.511396ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T17:06:52.259959Z","caller":"traceutil/trace.go:171","msg":"trace[1203022350] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:19156; }","duration":"141.755057ms","start":"2026-09-02T17:06:52.118176Z","end":"2026-09-02T17:06:52.259931Z","steps":["trace[1203022350] 'agreement among raft nodes before linearized reading'  (duration: 141.358615ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T17:06:52.260263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.558077ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"}
{"level":"info","ts":"2026-09-02T17:06:52.260348Z","caller":"traceutil/trace.go:171","msg":"trace[18633355] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:19156; }","duration":"192.704571ms","start":"2026-09-02T17:06:52.067626Z","end":"2026-09-02T17:06:52.260331Z","steps":["trace[18633355] 'agreement among raft nodes before linearized reading'  (duration: 192.425492ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T17:06:53.07871Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":16898}
{"level":"info","ts":"2026-09-02T17:06:53.182242Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":16898,"took":"100.058014ms","hash":1775120387,"current-db-size-bytes":57520128,"current-db-size":"58 MB","current-db-size-in-use-bytes":31879168,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-09-02T17:06:53.182311Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1775120387,"revision":16898,"compact-revision":14577}
{"level":"info","ts":"2026-09-02T17:07:01.025402Z","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-09-02T17:07:01.031452Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002}
{"level":"info","ts":"2026-09-02T17:07:01.031527Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002}
{"level":"info","ts":"2026-09-02T17:11:53.110332Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19167}
{"level":"info","ts":"2026-09-02T17:11:53.366728Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19167,"took":"252.762689ms","hash":3431179742,"current-db-size-bytes":57520128,"current-db-size":"58 MB","current-db-size-in-use-bytes":34025472,"current-db-size-in-use":"34 MB"}
{"level":"info","ts":"2026-09-02T17:11:53.366788Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3431179742,"revision":19167,"compact-revision":16898}
{"level":"info","ts":"2026-09-02T17:11:59.258405Z","caller":"traceutil/trace.go:171","msg":"trace[397958254] transaction","detail":"{read_only:false; response_revision:21648; number_of_response:1; }","duration":"129.068936ms","start":"2026-09-02T17:11:59.129318Z","end":"2026-09-02T17:11:59.258387Z","steps":["trace[397958254] 'process raft request'  (duration: 129.006325ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T17:11:59.258532Z","caller":"traceutil/trace.go:171","msg":"trace[1712658026] transaction","detail":"{read_only:false; response_revision:21647; number_of_response:1; }","duration":"134.177702ms","start":"2026-09-02T17:11:59.124334Z","end":"2026-09-02T17:11:59.258511Z","steps":["trace[1712658026] 'process raft request'  (duration: 133.921975ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T17:11:59.258699Z","caller":"traceutil/trace.go:171","msg":"trace[1303241610] transaction","detail":"{read_only:false; response_revision:21646; number_of_response:1; }","duration":"134.476282ms","start":"2026-09-02T17:11:59.124214Z","end":"2026-09-02T17:11:59.258691Z","steps":["trace[1303241610] 'process raft request'  (duration: 74.674587ms)","trace[1303241610] 'compare'  (duration: 59.272728ms)"],"step_count":2}
{"level":"info","ts":"2026-09-02T17:12:45.725304Z","caller":"traceutil/trace.go:171","msg":"trace[1542018071] transaction","detail":"{read_only:false; response_revision:21912; number_of_response:1; }","duration":"123.192028ms","start":"2026-09-02T17:12:45.602086Z","end":"2026-09-02T17:12:45.725278Z","steps":["trace[1542018071] 'process raft request'  (duration: 122.889329ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T17:12:51.311635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.674793ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16594533598801641153 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" mod_revision:21888 > success:<request_put:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" value_size:416 >> failure:<request_range:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" > >>","response":"size:18"}
{"level":"info","ts":"2026-09-02T17:12:51.311713Z","caller":"traceutil/trace.go:171","msg":"trace[189474000] linearizableReadLoop","detail":"{readStateIndex:22703; appliedIndex:22702; }","duration":"263.306502ms","start":"2026-09-02T17:12:51.048394Z","end":"2026-09-02T17:12:51.311701Z","steps":["trace[189474000] 'read index received'  (duration: 137.466853ms)","trace[189474000] 'applied index is now lower than readState.Index'  (duration: 125.838808ms)"],"step_count":2}
{"level":"info","ts":"2026-09-02T17:12:51.311729Z","caller":"traceutil/trace.go:171","msg":"trace[728586819] transaction","detail":"{read_only:false; response_revision:21949; number_of_response:1; }","duration":"317.565386ms","start":"2026-09-02T17:12:50.99415Z","end":"2026-09-02T17:12:51.311715Z","steps":["trace[728586819] 'process raft request'  (duration: 191.734588ms)","trace[728586819] 'compare'  (duration: 125.382115ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-02T17:12:51.311778Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T17:12:50.994131Z","time spent":"317.620837ms","remote":"127.0.0.1:51094","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" mod_revision:21888 > success:<request_put:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" value_size:416 >> failure:<request_range:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" > >"}
{"level":"warn","ts":"2026-09-02T17:12:51.311792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.394124ms","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-09-02T17:12:51.311818Z","caller":"traceutil/trace.go:171","msg":"trace[1588251181] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:21949; }","duration":"263.445156ms","start":"2026-09-02T17:12:51.04836Z","end":"2026-09-02T17:12:51.311805Z","steps":["trace[1588251181] 'agreement among raft nodes before linearized reading'  (duration: 263.401754ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T17:12:51.31189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.636803ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-02T17:12:51.311972Z","caller":"traceutil/trace.go:171","msg":"trace[2043677632] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:21949; }","duration":"228.726087ms","start":"2026-09-02T17:12:51.083227Z","end":"2026-09-02T17:12:51.311953Z","steps":["trace[2043677632] 'agreement among raft nodes before linearized reading'  (duration: 228.582452ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T17:13:07.092926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.815663ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-09-02T17:13:07.09301Z","caller":"traceutil/trace.go:171","msg":"trace[392679948] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:22028; }","duration":"277.941917ms","start":"2026-09-02T17:13:06.815051Z","end":"2026-09-02T17:13:07.092993Z","steps":["trace[392679948] 'range keys from in-memory index tree'  (duration: 277.634738ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T17:13:07.09354Z","caller":"traceutil/trace.go:171","msg":"trace[100326576] transaction","detail":"{read_only:false; response_revision:22029; number_of_response:1; }","duration":"146.586932ms","start":"2026-09-02T17:13:06.946931Z","end":"2026-09-02T17:13:07.093518Z","steps":["trace[100326576] 'process raft request'  (duration: 59.02299ms)","trace[100326576] 'compare'  (duration: 86.741616ms)"],"step_count":2}
{"level":"info","ts":"2026-09-02T17:13:07.104607Z","caller":"traceutil/trace.go:171","msg":"trace[713327371] linearizableReadLoop","detail":"{readStateIndex:22788; appliedIndex:22786; }","duration":"136.863505ms","start":"2026-09-02T17:13:06.967703Z","end":"2026-09-02T17:13:07.104567Z","steps":["trace[713327371] 'read index received'  (duration: 38.285827ms)","trace[713327371] 'applied index is now lower than readState.Index'  (duration: 98.576678ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-02T17:13:07.104782Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.060351ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"}
{"level":"info","ts":"2026-09-02T17:13:07.104749Z","caller":"traceutil/trace.go:171","msg":"trace[839013247] transaction","detail":"{read_only:false; response_revision:22030; number_of_response:1; }","duration":"153.357928ms","start":"2026-09-02T17:13:06.951351Z","end":"2026-09-02T17:13:07.104709Z","steps":["trace[839013247] 'process raft request'  (duration: 153.08832ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T17:13:07.104815Z","caller":"traceutil/trace.go:171","msg":"trace[1067295583] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:22030; }","duration":"137.147023ms","start":"2026-09-02T17:13:06.967656Z","end":"2026-09-02T17:13:07.104803Z","steps":["trace[1067295583] 'agreement among raft nodes before linearized reading'  (duration: 137.018009ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T17:13:12.130564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.470814ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/orders/\" range_end:\"/registry/acme.cert-manager.io/orders0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-02T17:13:12.13064Z","caller":"traceutil/trace.go:171","msg":"trace[2106479185] range","detail":"{range_begin:/registry/acme.cert-manager.io/orders/; range_end:/registry/acme.cert-manager.io/orders0; response_count:0; response_revision:22053; }","duration":"101.580428ms","start":"2026-09-02T17:13:12.029032Z","end":"2026-09-02T17:13:12.130613Z","steps":["trace[2106479185] 'count revisions from in-memory index tree'  (duration: 101.365452ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T17:13:13.125252Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16594533598801641433,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-09-02T17:13:13.511839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.193495804s","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-09-02T17:13:13.511922Z","caller":"traceutil/trace.go:171","msg":"trace[809587972] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:22054; }","duration":"1.193625008s","start":"2026-09-02T17:13:12.318279Z","end":"2026-09-02T17:13:13.511904Z","steps":["trace[809587972] 'count revisions from in-memory index tree'  (duration: 1.193353009s)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T17:13:13.511958Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T17:13:12.31823Z","time spent":"1.193717501s","remote":"127.0.0.1:33386","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":32,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "}
{"level":"info","ts":"2026-09-02T17:13:13.527357Z","caller":"traceutil/trace.go:171","msg":"trace[1580315345] transaction","detail":"{read_only:false; response_revision:22055; number_of_response:1; }","duration":"1.165167109s","start":"2026-09-02T17:13:12.362169Z","end":"2026-09-02T17:13:13.527336Z","steps":["trace[1580315345] 'process raft request'  (duration: 1.165016125s)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T17:13:13.527561Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T17:13:12.362151Z","time spent":"1.165258242s","remote":"127.0.0.1:51094","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:22003 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"warn","ts":"2026-09-02T17:13:14.331113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.823197ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16594533598801641435 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:22047 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:465 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >>","response":"size:18"}
{"level":"info","ts":"2026-09-02T17:13:14.331309Z","caller":"traceutil/trace.go:171","msg":"trace[307326090] transaction","detail":"{read_only:false; response_revision:22056; number_of_response:1; }","duration":"1.532408491s","start":"2026-09-02T17:13:12.79887Z","end":"2026-09-02T17:13:14.331278Z","steps":["trace[307326090] 'process raft request'  (duration: 1.306356657s)","trace[307326090] 'compare'  (duration: 225.57721ms)"],"step_count":2}
{"level":"info","ts":"2026-09-02T17:13:14.331352Z","caller":"traceutil/trace.go:171","msg":"trace[419425566] transaction","detail":"{read_only:false; response_revision:22057; number_of_response:1; }","duration":"1.175763274s","start":"2026-09-02T17:13:13.155573Z","end":"2026-09-02T17:13:14.331336Z","steps":["trace[419425566] 'process raft request'  (duration: 1.17563103s)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T17:13:14.33142Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T17:13:13.155547Z","time spent":"1.175840095s","remote":"127.0.0.1:51094","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:22049 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:477 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-09-02T17:13:14.331434Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T17:13:12.798845Z","time spent":"1.532520584s","remote":"127.0.0.1:51094","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:22047 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:465 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"info","ts":"2026-09-02T17:13:14.331564Z","caller":"traceutil/trace.go:171","msg":"trace[2095701257] linearizableReadLoop","detail":"{readStateIndex:22816; appliedIndex:22814; }","duration":"1.707030147s","start":"2026-09-02T17:13:12.624505Z","end":"2026-09-02T17:13:14.331535Z","steps":["trace[2095701257] 'read index received'  (duration: 902.730444ms)","trace[2095701257] 'applied index is now lower than readState.Index'  (duration: 804.298533ms)"],"step_count":2}
{"level":"info","ts":"2026-09-02T17:13:14.331696Z","caller":"traceutil/trace.go:171","msg":"trace[35920127] transaction","detail":"{read_only:false; response_revision:22058; number_of_response:1; }","duration":"1.168593903s","start":"2026-09-02T17:13:13.16309Z","end":"2026-09-02T17:13:14.331684Z","steps":["trace[35920127] 'process raft request'  (duration: 1.168213212s)"],"step_count":1}
{"level":"info","ts":"2026-09-02T17:13:14.331746Z","caller":"traceutil/trace.go:171","msg":"trace[354580157] transaction","detail":"{read_only:false; response_revision:22059; number_of_response:1; }","duration":"499.855477ms","start":"2026-09-02T17:13:13.831878Z","end":"2026-09-02T17:13:14.331734Z","steps":["trace[354580157] 'process raft request'  (duration: 499.587899ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T17:13:14.3318Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T17:13:13.831855Z","time spent":"499.919619ms","remote":"127.0.0.1:51094","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" mod_revision:22023 > success:<request_put:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" value_size:416 >> failure:<request_range:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" > >"}
{"level":"warn","ts":"2026-09-02T17:13:14.331795Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T17:13:13.163068Z","time spent":"1.168656195s","remote":"127.0.0.1:51094","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:22050 > 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-09-02T17:13:14.331855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.707350078s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"}
{"level":"info","ts":"2026-09-02T17:13:14.331909Z","caller":"traceutil/trace.go:171","msg":"trace[464337038] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:22059; }","duration":"1.70743201s","start":"2026-09-02T17:13:12.624457Z","end":"2026-09-02T17:13:14.331889Z","steps":["trace[464337038] 'agreement among raft nodes before linearized reading'  (duration: 1.707272814s)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T17:13:14.331936Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T17:13:12.624437Z","time spent":"1.707493772s","remote":"127.0.0.1:51094","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":506,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-09-02T17:13:14.332049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"611.020438ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/\" range_end:\"/registry/rabbitmq.com/rabbitmqclusters0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-09-02T17:13:14.332056Z","caller":"traceutil/trace.go:171","msg":"trace[1913111913] transaction","detail":"{read_only:false; response_revision:22060; number_of_response:1; }","duration":"334.009778ms","start":"2026-09-02T17:13:13.998035Z","end":"2026-09-02T17:13:14.332045Z","steps":["trace[1913111913] 'process raft request'  (duration: 333.634896ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T17:13:14.332075Z","caller":"traceutil/trace.go:171","msg":"trace[1052726082] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/; range_end:/registry/rabbitmq.com/rabbitmqclusters0; response_count:0; response_revision:22060; }","duration":"611.09697ms","start":"2026-09-02T17:13:13.72097Z","end":"2026-09-02T17:13:14.332067Z","steps":["trace[1052726082] 'agreement among raft nodes before linearized reading'  (duration: 611.030338ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T17:13:14.332098Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T17:13:13.720944Z","time spent":"611.149221ms","remote":"127.0.0.1:51342","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":8,"response size":32,"request content":"key:\"/registry/rabbitmq.com/rabbitmqclusters/\" range_end:\"/registry/rabbitmq.com/rabbitmqclusters0\" count_only:true "}
{"level":"warn","ts":"2026-09-02T17:13:14.332111Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T17:13:13.998013Z","time spent":"334.07352ms","remote":"127.0.0.1:51094","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:22053 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"warn","ts":"2026-09-02T17:13:14.332187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.534582528s","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-09-02T17:13:14.332255Z","caller":"traceutil/trace.go:171","msg":"trace[56981411] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:22060; }","duration":"1.534685921s","start":"2026-09-02T17:13:12.797557Z","end":"2026-09-02T17:13:14.332243Z","steps":["trace[56981411] 'agreement among raft nodes before linearized reading'  (duration: 1.534391792s)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T17:13:14.332267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.937703ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"}
{"level":"warn","ts":"2026-09-02T17:13:14.332281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.156619079s","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-09-02T17:13:14.33229Z","caller":"traceutil/trace.go:171","msg":"trace[913865285] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:22060; }","duration":"150.16646ms","start":"2026-09-02T17:13:14.182118Z","end":"2026-09-02T17:13:14.332284Z","steps":["trace[913865285] 'agreement among raft nodes before linearized reading'  (duration: 150.082157ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T17:13:14.332289Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T17:13:12.79754Z","time spent":"1.534740352s","remote":"127.0.0.1:51094","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":"info","ts":"2026-09-02T17:13:14.33231Z","caller":"traceutil/trace.go:171","msg":"trace[1179024272] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:22060; }","duration":"1.15667377s","start":"2026-09-02T17:13:13.175629Z","end":"2026-09-02T17:13:14.332302Z","steps":["trace[1179024272] 'agreement among raft nodes before linearized reading'  (duration: 1.156564607s)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T17:13:14.332331Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T17:13:13.175614Z","time spent":"1.156712231s","remote":"127.0.0.1:51094","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-09-02T17:13:14.332375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.247387348s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-02T17:13:14.332406Z","caller":"traceutil/trace.go:171","msg":"trace[254288387] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:22060; }","duration":"1.247446009s","start":"2026-09-02T17:13:13.08495Z","end":"2026-09-02T17:13:14.332396Z","steps":["trace[254288387] 'agreement among raft nodes before linearized reading'  (duration: 1.247399818s)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T17:13:14.332416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.1566532s","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-09-02T17:13:14.332427Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T17:13:13.084932Z","time spent":"1.247489651s","remote":"127.0.0.1:50810","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":30,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-09-02T17:13:14.332441Z","caller":"traceutil/trace.go:171","msg":"trace[1514841658] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:22060; }","duration":"1.156716601s","start":"2026-09-02T17:13:13.175716Z","end":"2026-09-02T17:13:14.332433Z","steps":["trace[1514841658] 'agreement among raft nodes before linearized reading'  (duration: 1.15665662s)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T17:13:14.332463Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T17:13:13.175695Z","time spent":"1.156761643s","remote":"127.0.0.1:51094","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":518,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-09-02T17:13:14.332466Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.290608956s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-09-02T17:13:14.332494Z","caller":"traceutil/trace.go:171","msg":"trace[1021129374] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:22060; }","duration":"1.290667078s","start":"2026-09-02T17:13:13.041818Z","end":"2026-09-02T17:13:14.332485Z","steps":["trace[1021129374] 'agreement among raft nodes before linearized reading'  (duration: 1.290618386s)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T17:13:14.332521Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T17:13:13.041803Z","time spent":"1.290712149s","remote":"127.0.0.1:51268","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":8,"response size":32,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "}
{"level":"warn","ts":"2026-09-02T17:13:14.843288Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16594533598801641442,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-09-02T17:13:15.065034Z","caller":"traceutil/trace.go:171","msg":"trace[1800741089] transaction","detail":"{read_only:false; response_revision:22061; number_of_response:1; }","duration":"728.674355ms","start":"2026-09-02T17:13:14.336335Z","end":"2026-09-02T17:13:15.065009Z","steps":["trace[1800741089] 'process raft request'  (duration: 728.529531ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T17:13:15.065182Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T17:13:14.336315Z","time spent":"728.792179ms","remote":"127.0.0.1:51094","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:22052 > 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":"warn","ts":"2026-09-02T17:13:16.011425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"391.282724ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16594533598801641444 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:22046 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:18"}
{"level":"info","ts":"2026-09-02T17:13:16.011657Z","caller":"traceutil/trace.go:171","msg":"trace[503188169] transaction","detail":"{read_only:false; response_revision:22062; number_of_response:1; }","duration":"1.674476264s","start":"2026-09-02T17:13:14.337144Z","end":"2026-09-02T17:13:16.01162Z","steps":["trace[503188169] 'process raft request'  (duration: 1.282905451s)","trace[503188169] 'compare'  (duration: 390.883183ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-02T17:13:16.011795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.669031358s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-02T17:13:16.011828Z","caller":"traceutil/trace.go:171","msg":"trace[569432156] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:22065; }","duration":"1.66909423s","start":"2026-09-02T17:13:14.342724Z","end":"2026-09-02T17:13:16.011818Z","steps":["trace[569432156] 'agreement among raft nodes before linearized reading'  (duration: 1.668996867s)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T17:13:16.011828Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T17:13:14.337135Z","time spent":"1.674597948s","remote":"127.0.0.1:51094","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:22046 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-09-02T17:13:16.011857Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T17:13:14.342708Z","time spent":"1.669141671s","remote":"127.0.0.1:50810","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":30,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-09-02T17:13:16.011697Z","caller":"traceutil/trace.go:171","msg":"trace[289338634] linearizableReadLoop","detail":"{readStateIndex:22825; appliedIndex:22820; }","duration":"1.668920925s","start":"2026-09-02T17:13:14.34276Z","end":"2026-09-02T17:13:16.011681Z","steps":["trace[289338634] 'read index received'  (duration: 722.131597ms)","trace[289338634] 'applied index is now lower than readState.Index'  (duration: 946.788528ms)"],"step_count":2}
{"level":"info","ts":"2026-09-02T17:13:16.012185Z","caller":"traceutil/trace.go:171","msg":"trace[1676969066] transaction","detail":"{read_only:false; response_revision:22063; number_of_response:1; }","duration":"1.675000521s","start":"2026-09-02T17:13:14.337172Z","end":"2026-09-02T17:13:16.012173Z","steps":["trace[1676969066] 'process raft request'  (duration: 1.67434621s)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T17:13:16.012199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.34714148s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephbuckettopics/\" range_end:\"/registry/ceph.rook.io/cephbuckettopics0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-09-02T17:13:16.012272Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T17:13:14.337155Z","time spent":"1.675082654s","remote":"127.0.0.1:51094","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:22048 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-09-02T17:13:16.012286Z","caller":"traceutil/trace.go:171","msg":"trace[279112952] range","detail":"{range_begin:/registry/ceph.rook.io/cephbuckettopics/; range_end:/registry/ceph.rook.io/cephbuckettopics0; response_count:0; response_revision:22065; }","duration":"1.347265734s","start":"2026-09-02T17:13:14.665001Z","end":"2026-09-02T17:13:16.012267Z","steps":["trace[279112952] 'agreement among raft nodes before linearized reading'  (duration: 1.347143661s)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T17:13:16.012333Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T17:13:14.66498Z","time spent":"1.347335347s","remote":"127.0.0.1:37292","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":0,"response size":30,"request content":"key:\"/registry/ceph.rook.io/cephbuckettopics/\" range_end:\"/registry/ceph.rook.io/cephbuckettopics0\" count_only:true "}
{"level":"info","ts":"2026-09-02T17:13:16.012463Z","caller":"traceutil/trace.go:171","msg":"trace[228796047] transaction","detail":"{read_only:false; response_revision:22064; number_of_response:1; }","duration":"1.674026191s","start":"2026-09-02T17:13:14.338412Z","end":"2026-09-02T17:13:16.012439Z","steps":["trace[228796047] 'process raft request'  (duration: 1.673195085s)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T17:13:16.01255Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T17:13:14.338404Z","time spent":"1.674102024s","remote":"127.0.0.1:51094","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:22051 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-09-02T17:13:16.012738Z","caller":"traceutil/trace.go:171","msg":"trace[451625074] transaction","detail":"{read_only:false; response_revision:22065; number_of_response:1; }","duration":"1.674046852s","start":"2026-09-02T17:13:14.338676Z","end":"2026-09-02T17:13:16.012723Z","steps":["trace[451625074] 'process raft request'  (duration: 1.672963309s)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T17:13:16.012799Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T17:13:14.338667Z","time spent":"1.674095383s","remote":"127.0.0.1:51094","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:22054 > 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\" > >"}
{"level":"warn","ts":"2026-09-02T17:13:16.013004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"951.364228ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"}
{"level":"info","ts":"2026-09-02T17:13:16.013058Z","caller":"traceutil/trace.go:171","msg":"trace[1401252519] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:22065; }","duration":"951.458541ms","start":"2026-09-02T17:13:15.061582Z","end":"2026-09-02T17:13:16.013041Z","steps":["trace[1401252519] 'agreement among raft nodes before linearized reading'  (duration: 951.263865ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T17:13:16.013091Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T17:13:15.061564Z","time spent":"951.519472ms","remote":"127.0.0.1:50996","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12237,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "}
{"level":"warn","ts":"2026-09-02T17:13:16.762067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"644.463567ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5652"}
{"level":"info","ts":"2026-09-02T17:13:16.762167Z","caller":"traceutil/trace.go:171","msg":"trace[1766553788] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:22065; }","duration":"644.59873ms","start":"2026-09-02T17:13:16.117546Z","end":"2026-09-02T17:13:16.762145Z","steps":["trace[1766553788] 'range keys from in-memory index tree'  (duration: 644.101196ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T17:13:16.762229Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T17:13:16.117532Z","time spent":"644.665253ms","remote":"127.0.0.1:33394","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5676,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "}
{"level":"warn","ts":"2026-09-02T17:13:16.762191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"381.583939ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16594533598801641459 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:22020 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >>","response":"size:18"}
{"level":"info","ts":"2026-09-02T17:13:16.762312Z","caller":"traceutil/trace.go:171","msg":"trace[1740210491] transaction","detail":"{read_only:false; response_revision:22066; number_of_response:1; }","duration":"477.161674ms","start":"2026-09-02T17:13:16.285132Z","end":"2026-09-02T17:13:16.762293Z","steps":["trace[1740210491] 'process raft request'  (duration: 95.351209ms)","trace[1740210491] 'compare'  (duration: 381.30868ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-02T17:13:16.762383Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T17:13:16.285051Z","time spent":"477.292297ms","remote":"127.0.0.1:51094","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:22020 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"warn","ts":"2026-09-02T17:13:17.288046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.829521ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16594533598801641460 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:22057 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >>","response":"size:18"}
{"level":"info","ts":"2026-09-02T17:13:17.288319Z","caller":"traceutil/trace.go:171","msg":"trace[451344185] linearizableReadLoop","detail":"{readStateIndex:22830; appliedIndex:22825; }","duration":"932.507473ms","start":"2026-09-02T17:13:16.355794Z","end":"2026-09-02T17:13:17.288301Z","steps":["trace[451344185] 'read index received'  (duration: 24.774386ms)","trace[451344185] 'applied index is now lower than readState.Index'  (duration: 907.732137ms)"],"step_count":2}
{"level":"info","ts":"2026-09-02T17:13:17.288459Z","caller":"traceutil/trace.go:171","msg":"trace[1030745660] transaction","detail":"{read_only:false; response_revision:22067; number_of_response:1; }","duration":"951.913955ms","start":"2026-09-02T17:13:16.336516Z","end":"2026-09-02T17:13:17.288429Z","steps":["trace[1030745660] 'process raft request'  (duration: 582.60102ms)","trace[1030745660] 'compare'  (duration: 368.683387ms)"],"step_count":2}
{"level":"info","ts":"2026-09-02T17:13:17.288465Z","caller":"traceutil/trace.go:171","msg":"trace[1966086115] transaction","detail":"{read_only:false; response_revision:22070; number_of_response:1; }","duration":"948.371707ms","start":"2026-09-02T17:13:16.34006Z","end":"2026-09-02T17:13:17.288432Z","steps":["trace[1966086115] 'process raft request'  (duration: 948.205932ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T17:13:17.288535Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T17:13:16.336486Z","time spent":"952.010978ms","remote":"127.0.0.1:51094","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:22057 > 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-09-02T17:13:17.288544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.101207ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/challenges/\" range_end:\"/registry/acme.cert-manager.io/challenges0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-02T17:13:17.288617Z","caller":"traceutil/trace.go:171","msg":"trace[4108129] range","detail":"{range_begin:/registry/acme.cert-manager.io/challenges/; range_end:/registry/acme.cert-manager.io/challenges0; response_count:0; response_revision:22070; }","duration":"327.22151ms","start":"2026-09-02T17:13:16.961375Z","end":"2026-09-02T17:13:17.288597Z","steps":["trace[4108129] 'agreement among raft nodes before linearized reading'  (duration: 327.069856ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T17:13:17.288603Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T17:13:16.340042Z","time spent":"948.48575ms","remote":"127.0.0.1:51094","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:22058 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"warn","ts":"2026-09-02T17:13:17.288655Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T17:13:16.961355Z","time spent":"327.291423ms","remote":"127.0.0.1:57434","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":30,"request content":"key:\"/registry/acme.cert-manager.io/challenges/\" range_end:\"/registry/acme.cert-manager.io/challenges0\" count_only:true "}
{"level":"info","ts":"2026-09-02T17:13:17.288814Z","caller":"traceutil/trace.go:171","msg":"trace[1135803754] transaction","detail":"{read_only:false; response_revision:22068; number_of_response:1; }","duration":"950.690048ms","start":"2026-09-02T17:13:16.338112Z","end":"2026-09-02T17:13:17.288802Z","steps":["trace[1135803754] 'process raft request'  (duration: 950.034049ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T17:13:17.288864Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T17:13:16.338082Z","time spent":"950.75404ms","remote":"127.0.0.1:51094","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:22060 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"info","ts":"2026-09-02T17:13:17.288932Z","caller":"traceutil/trace.go:171","msg":"trace[1475520829] transaction","detail":"{read_only:false; response_revision:22069; number_of_response:1; }","duration":"950.583874ms","start":"2026-09-02T17:13:16.338329Z","end":"2026-09-02T17:13:17.288912Z","steps":["trace[1475520829] 'process raft request'  (duration: 949.873353ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T17:13:17.288948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"933.163114ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.52\" ","response":"range_response_count:1 size:137"}
{"level":"warn","ts":"2026-09-02T17:13:17.288962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.54658ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-02T17:13:17.288991Z","caller":"traceutil/trace.go:171","msg":"trace[4761314] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:22070; }","duration":"205.594481ms","start":"2026-09-02T17:13:17.083388Z","end":"2026-09-02T17:13:17.288983Z","steps":["trace[4761314] 'agreement among raft nodes before linearized reading'  (duration: 205.539659ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T17:13:17.28898Z","caller":"traceutil/trace.go:171","msg":"trace[562818558] range","detail":"{range_begin:/registry/masterleases/162.253.55.52; range_end:; response_count:1; response_revision:22070; }","duration":"933.223775ms","start":"2026-09-02T17:13:16.355746Z","end":"2026-09-02T17:13:17.28897Z","steps":["trace[562818558] 'agreement among raft nodes before linearized reading'  (duration: 933.104651ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T17:13:17.289051Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T17:13:16.338294Z","time spent":"950.679667ms","remote":"127.0.0.1:51094","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:22056 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:465 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-09-02T17:13:17.289089Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T17:13:16.355728Z","time spent":"933.34777ms","remote":"127.0.0.1:50836","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":161,"request content":"key:\"/registry/masterleases/162.253.55.52\" "}
{"level":"warn","ts":"2026-09-02T17:13:17.289121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.015061ms","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-09-02T17:13:17.289232Z","caller":"traceutil/trace.go:171","msg":"trace[1671897916] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:22070; }","duration":"219.111174ms","start":"2026-09-02T17:13:17.070073Z","end":"2026-09-02T17:13:17.289185Z","steps":["trace[1671897916] 'agreement among raft nodes before linearized reading'  (duration: 218.852066ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T17:13:25.492844Z","caller":"traceutil/trace.go:171","msg":"trace[811039246] transaction","detail":"{read_only:false; response_revision:22110; number_of_response:1; }","duration":"130.546582ms","start":"2026-09-02T17:13:25.362268Z","end":"2026-09-02T17:13:25.492815Z","steps":["trace[811039246] 'process raft request'  (duration: 101.924799ms)","trace[811039246] 'compare'  (duration: 28.323764ms)"],"step_count":2}
{"level":"info","ts":"2026-09-02T17:13:25.493066Z","caller":"traceutil/trace.go:171","msg":"trace[658032093] transaction","detail":"{read_only:false; response_revision:22111; number_of_response:1; }","duration":"122.785906ms","start":"2026-09-02T17:13:25.370261Z","end":"2026-09-02T17:13:25.493047Z","steps":["trace[658032093] 'process raft request'  (duration: 122.467467ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T17:13:25.493382Z","caller":"traceutil/trace.go:171","msg":"trace[1729052688] linearizableReadLoop","detail":"{readStateIndex:22874; appliedIndex:22871; }","duration":"116.0321ms","start":"2026-09-02T17:13:25.377326Z","end":"2026-09-02T17:13:25.493358Z","steps":["trace[1729052688] 'read index received'  (duration: 86.910351ms)","trace[1729052688] 'applied index is now lower than readState.Index'  (duration: 29.120678ms)"],"step_count":2}
{"level":"info","ts":"2026-09-02T17:13:25.493508Z","caller":"traceutil/trace.go:171","msg":"trace[593618332] transaction","detail":"{read_only:false; response_revision:22112; number_of_response:1; }","duration":"121.449964ms","start":"2026-09-02T17:13:25.372048Z","end":"2026-09-02T17:13:25.493498Z","steps":["trace[593618332] 'process raft request'  (duration: 120.920398ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T17:13:25.493698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.359379ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"}
{"level":"info","ts":"2026-09-02T17:13:25.493744Z","caller":"traceutil/trace.go:171","msg":"trace[1067329978] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:22112; }","duration":"116.419541ms","start":"2026-09-02T17:13:25.377312Z","end":"2026-09-02T17:13:25.493731Z","steps":["trace[1067329978] 'agreement among raft nodes before linearized reading'  (duration: 116.140762ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T17:13:26.251169Z","caller":"traceutil/trace.go:171","msg":"trace[1554734219] transaction","detail":"{read_only:false; response_revision:22117; number_of_response:1; }","duration":"151.269464ms","start":"2026-09-02T17:13:26.09987Z","end":"2026-09-02T17:13:26.25114Z","steps":["trace[1554734219] 'process raft request'  (duration: 147.978714ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T17:13:27.659241Z","caller":"traceutil/trace.go:171","msg":"trace[1337988480] linearizableReadLoop","detail":"{readStateIndex:22886; appliedIndex:22884; }","duration":"144.159077ms","start":"2026-09-02T17:13:27.515029Z","end":"2026-09-02T17:13:27.659188Z","steps":["trace[1337988480] 'read index received'  (duration: 142.130916ms)","trace[1337988480] 'applied index is now lower than readState.Index'  (duration: 2.027271ms)"],"step_count":2}
{"level":"info","ts":"2026-09-02T17:13:27.659255Z","caller":"traceutil/trace.go:171","msg":"trace[1207536085] transaction","detail":"{read_only:false; response_revision:22122; number_of_response:1; }","duration":"161.053932ms","start":"2026-09-02T17:13:27.498168Z","end":"2026-09-02T17:13:27.659221Z","steps":["trace[1207536085] 'process raft request'  (duration: 159.114794ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T17:13:27.659264Z","caller":"traceutil/trace.go:171","msg":"trace[419545239] transaction","detail":"{read_only:false; response_revision:22123; number_of_response:1; }","duration":"160.682151ms","start":"2026-09-02T17:13:27.498548Z","end":"2026-09-02T17:13:27.65923Z","steps":["trace[419545239] 'process raft request'  (duration: 160.544407ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T17:13:27.659454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.409954ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"}
{"level":"info","ts":"2026-09-02T17:13:27.659494Z","caller":"traceutil/trace.go:171","msg":"trace[314464841] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:22123; }","duration":"144.486267ms","start":"2026-09-02T17:13:27.514995Z","end":"2026-09-02T17:13:27.659482Z","steps":["trace[314464841] 'agreement among raft nodes before linearized reading'  (duration: 144.355973ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T17:13:29.674187Z","caller":"traceutil/trace.go:171","msg":"trace[560851375] transaction","detail":"{read_only:false; response_revision:22131; number_of_response:1; }","duration":"158.214636ms","start":"2026-09-02T17:13:29.515947Z","end":"2026-09-02T17:13:29.674162Z","steps":["trace[560851375] 'process raft request'  (duration: 70.417158ms)","trace[560851375] 'compare'  (duration: 87.538721ms)"],"step_count":2}
{"level":"info","ts":"2026-09-02T17:13:29.77173Z","caller":"traceutil/trace.go:171","msg":"trace[1357231613] transaction","detail":"{read_only:false; response_revision:22133; number_of_response:1; }","duration":"106.075776ms","start":"2026-09-02T17:13:29.665605Z","end":"2026-09-02T17:13:29.771681Z","steps":["trace[1357231613] 'process raft request'  (duration: 105.87483ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T17:13:32.27979Z","caller":"traceutil/trace.go:171","msg":"trace[516977351] transaction","detail":"{read_only:false; response_revision:22144; number_of_response:1; }","duration":"134.362678ms","start":"2026-09-02T17:13:32.145391Z","end":"2026-09-02T17:13:32.279754Z","steps":["trace[516977351] 'process raft request'  (duration: 134.006058ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T17:13:32.280376Z","caller":"traceutil/trace.go:171","msg":"trace[610443853] linearizableReadLoop","detail":"{readStateIndex:22907; appliedIndex:22906; }","duration":"131.868172ms","start":"2026-09-02T17:13:32.147718Z","end":"2026-09-02T17:13:32.279586Z","steps":["trace[610443853] 'read index received'  (duration: 131.572834ms)","trace[610443853] 'applied index is now lower than readState.Index'  (duration: 293.218µs)"],"step_count":2}
{"level":"warn","ts":"2026-09-02T17:13:32.280817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.148596ms","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-09-02T17:13:32.280864Z","caller":"traceutil/trace.go:171","msg":"trace[810300710] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:22144; }","duration":"123.233179ms","start":"2026-09-02T17:13:32.157616Z","end":"2026-09-02T17:13:32.280849Z","steps":["trace[810300710] 'agreement among raft nodes before linearized reading'  (duration: 122.988702ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T17:13:32.281295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.527071ms","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-09-02T17:13:32.281331Z","caller":"traceutil/trace.go:171","msg":"trace[226397834] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:22144; }","duration":"109.586202ms","start":"2026-09-02T17:13:32.171735Z","end":"2026-09-02T17:13:32.281322Z","steps":["trace[226397834] 'agreement among raft nodes before linearized reading'  (duration: 109.486509ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T17:13:32.280298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.47645ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5652"}
{"level":"info","ts":"2026-09-02T17:13:32.28217Z","caller":"traceutil/trace.go:171","msg":"trace[1727124231] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:22144; }","duration":"134.342448ms","start":"2026-09-02T17:13:32.14765Z","end":"2026-09-02T17:13:32.281992Z","steps":["trace[1727124231] 'agreement among raft nodes before linearized reading'  (duration: 132.227643ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T17:13:32.405805Z","caller":"traceutil/trace.go:171","msg":"trace[1745673074] transaction","detail":"{read_only:false; response_revision:22145; number_of_response:1; }","duration":"116.427001ms","start":"2026-09-02T17:13:32.289343Z","end":"2026-09-02T17:13:32.405769Z","steps":["trace[1745673074] 'process raft request'  (duration: 49.965974ms)","trace[1745673074] 'compare'  (duration: 66.148578ms)"],"step_count":2}
{"level":"info","ts":"2026-09-02T17:13:32.405956Z","caller":"traceutil/trace.go:171","msg":"trace[293621209] transaction","detail":"{read_only:false; response_revision:22146; number_of_response:1; }","duration":"116.470732ms","start":"2026-09-02T17:13:32.289441Z","end":"2026-09-02T17:13:32.405912Z","steps":["trace[293621209] 'process raft request'  (duration: 116.256656ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T17:13:32.615588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.792279ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16594533598801641661 > lease_revoke:<id:664ba062f1db3ffa>","response":"size:30"}
{"level":"info","ts":"2026-09-02T17:13:32.615686Z","caller":"traceutil/trace.go:171","msg":"trace[209789035] linearizableReadLoop","detail":"{readStateIndex:22910; appliedIndex:22907; }","duration":"239.241047ms","start":"2026-09-02T17:13:32.376427Z","end":"2026-09-02T17:13:32.615668Z","steps":["trace[209789035] 'read index received'  (duration: 87.323µs)","trace[209789035] 'applied index is now lower than readState.Index'  (duration: 239.152244ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-02T17:13:32.615927Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.482865ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-09-02T17:13:32.615981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.599833ms","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-09-02T17:13:32.61601Z","caller":"traceutil/trace.go:171","msg":"trace[1427891013] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:22146; }","duration":"239.587968ms","start":"2026-09-02T17:13:32.376402Z","end":"2026-09-02T17:13:32.61599Z","steps":["trace[1427891013] 'agreement among raft nodes before linearized reading'  (duration: 239.440974ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T17:13:32.616031Z","caller":"traceutil/trace.go:171","msg":"trace[1314083917] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:22146; }","duration":"229.696696ms","start":"2026-09-02T17:13:32.386319Z","end":"2026-09-02T17:13:32.616015Z","steps":["trace[1314083917] 'agreement among raft nodes before linearized reading'  (duration: 229.49701ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T17:13:34.569887Z","caller":"traceutil/trace.go:171","msg":"trace[369944759] transaction","detail":"{read_only:false; response_revision:22155; number_of_response:1; }","duration":"155.781532ms","start":"2026-09-02T17:13:34.414062Z","end":"2026-09-02T17:13:34.569843Z","steps":["trace[369944759] 'process raft request'  (duration: 142.93058ms)","trace[369944759] 'compare'  (duration: 12.448439ms)"],"step_count":2}
{"level":"info","ts":"2026-09-02T17:13:34.584323Z","caller":"traceutil/trace.go:171","msg":"trace[1000645203] transaction","detail":"{read_only:false; response_revision:22156; number_of_response:1; }","duration":"169.742187ms","start":"2026-09-02T17:13:34.414543Z","end":"2026-09-02T17:13:34.584286Z","steps":["trace[1000645203] 'process raft request'  (duration: 169.537991ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T17:13:34.80425Z","caller":"traceutil/trace.go:171","msg":"trace[125110057] transaction","detail":"{read_only:false; response_revision:22157; number_of_response:1; }","duration":"136.69879ms","start":"2026-09-02T17:13:34.667514Z","end":"2026-09-02T17:13:34.804213Z","steps":["trace[125110057] 'process raft request'  (duration: 115.0421ms)","trace[125110057] 'compare'  (duration: 21.424383ms)"],"step_count":2}
{"level":"info","ts":"2026-09-02T17:13:34.804255Z","caller":"traceutil/trace.go:171","msg":"trace[1887365377] linearizableReadLoop","detail":"{readStateIndex:22921; appliedIndex:22920; }","duration":"118.67487ms","start":"2026-09-02T17:13:34.685509Z","end":"2026-09-02T17:13:34.804183Z","steps":["trace[1887365377] 'read index received'  (duration: 97.01254ms)","trace[1887365377] 'applied index is now lower than readState.Index'  (duration: 21.66061ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-02T17:13:34.804523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.998089ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/scrapeconfigs/\" range_end:\"/registry/monitoring.coreos.com/scrapeconfigs0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-02T17:13:34.804586Z","caller":"traceutil/trace.go:171","msg":"trace[448114540] range","detail":"{range_begin:/registry/monitoring.coreos.com/scrapeconfigs/; range_end:/registry/monitoring.coreos.com/scrapeconfigs0; response_count:0; response_revision:22157; }","duration":"119.145954ms","start":"2026-09-02T17:13:34.685425Z","end":"2026-09-02T17:13:34.804571Z","steps":["trace[448114540] 'agreement among raft nodes before linearized reading'  (duration: 118.924897ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T17:13:35.812744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.986976ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectstoreusers/\" range_end:\"/registry/ceph.rook.io/cephobjectstoreusers0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-02T17:13:35.812871Z","caller":"traceutil/trace.go:171","msg":"trace[1836602683] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectstoreusers/; range_end:/registry/ceph.rook.io/cephobjectstoreusers0; response_count:0; response_revision:22158; }","duration":"114.186823ms","start":"2026-09-02T17:13:35.698652Z","end":"2026-09-02T17:13:35.812839Z","steps":["trace[1836602683] 'count revisions from in-memory index tree'  (duration: 113.873933ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T17:13:36.757588Z","caller":"traceutil/trace.go:171","msg":"trace[1924842293] transaction","detail":"{read_only:false; response_revision:22166; number_of_response:1; }","duration":"164.001712ms","start":"2026-09-02T17:13:36.593535Z","end":"2026-09-02T17:13:36.757537Z","steps":["trace[1924842293] 'process raft request'  (duration: 114.942726ms)","trace[1924842293] 'compare'  (duration: 48.626573ms)"],"step_count":2}
{"level":"info","ts":"2026-09-02T17:13:37.757032Z","caller":"traceutil/trace.go:171","msg":"trace[221115481] transaction","detail":"{read_only:false; response_revision:22171; number_of_response:1; }","duration":"179.526296ms","start":"2026-09-02T17:13:37.577481Z","end":"2026-09-02T17:13:37.757007Z","steps":["trace[221115481] 'process raft request'  (duration: 103.534378ms)","trace[221115481] 'compare'  (duration: 75.789151ms)"],"step_count":2}
{"level":"info","ts":"2026-09-02T17:13:38.525643Z","caller":"traceutil/trace.go:171","msg":"trace[1802857277] transaction","detail":"{read_only:false; response_revision:22177; number_of_response:1; }","duration":"101.94903ms","start":"2026-09-02T17:13:38.423666Z","end":"2026-09-02T17:13:38.525615Z","steps":["trace[1802857277] 'process raft request'  (duration: 101.560538ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T17:13:38.907666Z","caller":"traceutil/trace.go:171","msg":"trace[1114086068] transaction","detail":"{read_only:false; response_revision:22179; number_of_response:1; }","duration":"116.615908ms","start":"2026-09-02T17:13:38.79101Z","end":"2026-09-02T17:13:38.907625Z","steps":["trace[1114086068] 'process raft request'  (duration: 116.402132ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T17:13:39.865609Z","caller":"traceutil/trace.go:171","msg":"trace[1457059739] transaction","detail":"{read_only:false; response_revision:22181; number_of_response:1; }","duration":"101.883268ms","start":"2026-09-02T17:13:39.76368Z","end":"2026-09-02T17:13:39.865563Z","steps":["trace[1457059739] 'process raft request'  (duration: 101.524347ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T17:13:40.206916Z","caller":"traceutil/trace.go:171","msg":"trace[585670380] transaction","detail":"{read_only:false; response_revision:22182; number_of_response:1; }","duration":"295.141353ms","start":"2026-09-02T17:13:39.911745Z","end":"2026-09-02T17:13:40.206887Z","steps":["trace[585670380] 'process raft request'  (duration: 279.430444ms)","trace[585670380] 'compare'  (duration: 15.40057ms)"],"step_count":2}
{"level":"info","ts":"2026-09-02T17:13:40.295451Z","caller":"traceutil/trace.go:171","msg":"trace[2105084738] linearizableReadLoop","detail":"{readStateIndex:22949; appliedIndex:22946; }","duration":"209.785859ms","start":"2026-09-02T17:13:40.08564Z","end":"2026-09-02T17:13:40.295426Z","steps":["trace[2105084738] 'read index received'  (duration: 105.629452ms)","trace[2105084738] 'applied index is now lower than readState.Index'  (duration: 104.155417ms)"],"step_count":2}
{"level":"info","ts":"2026-09-02T17:13:40.295534Z","caller":"traceutil/trace.go:171","msg":"trace[1843065122] transaction","detail":"{read_only:false; response_revision:22183; number_of_response:1; }","duration":"372.973275ms","start":"2026-09-02T17:13:39.922535Z","end":"2026-09-02T17:13:40.295508Z","steps":["trace[1843065122] 'process raft request'  (duration: 372.728638ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T17:13:40.29557Z","caller":"traceutil/trace.go:171","msg":"trace[137298339] transaction","detail":"{read_only:false; response_revision:22184; number_of_response:1; }","duration":"355.533444ms","start":"2026-09-02T17:13:39.940026Z","end":"2026-09-02T17:13:40.295559Z","steps":["trace[137298339] 'process raft request'  (duration: 355.359039ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T17:13:40.295668Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T17:13:39.940008Z","time spent":"355.584496ms","remote":"127.0.0.1:51094","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:22174 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"warn","ts":"2026-09-02T17:13:40.295668Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T17:13:39.922515Z","time spent":"373.076379ms","remote":"127.0.0.1:51094","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:22173 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"warn","ts":"2026-09-02T17:13:40.295796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.1358ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-02T17:13:40.29588Z","caller":"traceutil/trace.go:171","msg":"trace[1242853364] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:22184; }","duration":"210.278664ms","start":"2026-09-02T17:13:40.085583Z","end":"2026-09-02T17:13:40.295862Z","steps":["trace[1242853364] 'agreement among raft nodes before linearized reading'  (duration: 210.102429ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T17:13:40.295886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.294615ms","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-09-02T17:13:40.295976Z","caller":"traceutil/trace.go:171","msg":"trace[1901465554] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:22184; }","duration":"171.45903ms","start":"2026-09-02T17:13:40.124492Z","end":"2026-09-02T17:13:40.295951Z","steps":["trace[1901465554] 'agreement among raft nodes before linearized reading'  (duration: 171.172111ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T17:13:42.391309Z","caller":"traceutil/trace.go:171","msg":"trace[1288050692] transaction","detail":"{read_only:false; response_revision:22191; number_of_response:1; }","duration":"178.644459ms","start":"2026-09-02T17:13:42.212635Z","end":"2026-09-02T17:13:42.391279Z","steps":["trace[1288050692] 'process raft request'  (duration: 178.451804ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T17:13:42.435456Z","caller":"traceutil/trace.go:171","msg":"trace[1134728115] transaction","detail":"{read_only:false; response_revision:22193; number_of_response:1; }","duration":"132.995446ms","start":"2026-09-02T17:13:42.302432Z","end":"2026-09-02T17:13:42.435427Z","steps":["trace[1134728115] 'process raft request'  (duration: 132.896504ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T17:13:42.435592Z","caller":"traceutil/trace.go:171","msg":"trace[801532446] transaction","detail":"{read_only:false; response_revision:22192; number_of_response:1; }","duration":"133.476311ms","start":"2026-09-02T17:13:42.302101Z","end":"2026-09-02T17:13:42.435578Z","steps":["trace[801532446] 'process raft request'  (duration: 133.10005ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T17:13:42.576825Z","caller":"traceutil/trace.go:171","msg":"trace[1641154365] transaction","detail":"{read_only:false; response_revision:22194; number_of_response:1; }","duration":"133.854963ms","start":"2026-09-02T17:13:42.442947Z","end":"2026-09-02T17:13:42.576802Z","steps":["trace[1641154365] 'process raft request'  (duration: 133.474361ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T17:13:42.829713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.434091ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16594533598801641785 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:22186 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:18"}
{"level":"info","ts":"2026-09-02T17:13:42.829853Z","caller":"traceutil/trace.go:171","msg":"trace[1195172251] linearizableReadLoop","detail":"{readStateIndex:22961; appliedIndex:22960; }","duration":"246.839039ms","start":"2026-09-02T17:13:42.582996Z","end":"2026-09-02T17:13:42.829835Z","steps":["trace[1195172251] 'read index received'  (duration: 130.329135ms)","trace[1195172251] 'applied index is now lower than readState.Index'  (duration: 116.508094ms)"],"step_count":2}
{"level":"info","ts":"2026-09-02T17:13:42.829957Z","caller":"traceutil/trace.go:171","msg":"trace[738524362] transaction","detail":"{read_only:false; response_revision:22195; number_of_response:1; }","duration":"247.892611ms","start":"2026-09-02T17:13:42.582047Z","end":"2026-09-02T17:13:42.82994Z","steps":["trace[738524362] 'process raft request'  (duration: 131.12187ms)","trace[738524362] 'compare'  (duration: 116.308097ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-02T17:13:42.830238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.2178ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"}
{"level":"info","ts":"2026-09-02T17:13:42.830333Z","caller":"traceutil/trace.go:171","msg":"trace[1884978668] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:22195; }","duration":"247.344514ms","start":"2026-09-02T17:13:42.582966Z","end":"2026-09-02T17:13:42.830311Z","steps":["trace[1884978668] 'agreement among raft nodes before linearized reading'  (duration: 247.064875ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T17:13:42.830238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.439262ms","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-09-02T17:13:42.830454Z","caller":"traceutil/trace.go:171","msg":"trace[435165458] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:22195; }","duration":"137.745271ms","start":"2026-09-02T17:13:42.692693Z","end":"2026-09-02T17:13:42.830438Z","steps":["trace[435165458] 'agreement among raft nodes before linearized reading'  (duration: 137.328018ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T17:13:43.115476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.023975ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-09-02T17:13:43.115565Z","caller":"traceutil/trace.go:171","msg":"trace[818643856] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:22196; }","duration":"149.178639ms","start":"2026-09-02T17:13:42.966367Z","end":"2026-09-02T17:13:43.115545Z","steps":["trace[818643856] 'range keys from in-memory index tree'  (duration: 148.625424ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T17:13:43.436665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.440013ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16594533598801641795 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:22189 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:18"}
{"level":"info","ts":"2026-09-02T17:13:43.436788Z","caller":"traceutil/trace.go:171","msg":"trace[842247785] linearizableReadLoop","detail":"{readStateIndex:22964; appliedIndex:22962; }","duration":"304.775057ms","start":"2026-09-02T17:13:43.131993Z","end":"2026-09-02T17:13:43.436768Z","steps":["trace[842247785] 'read index received'  (duration: 28.413697ms)","trace[842247785] 'applied index is now lower than readState.Index'  (duration: 276.35953ms)"],"step_count":2}
{"level":"info","ts":"2026-09-02T17:13:43.436834Z","caller":"traceutil/trace.go:171","msg":"trace[276816397] transaction","detail":"{read_only:false; response_revision:22198; number_of_response:1; }","duration":"315.478173ms","start":"2026-09-02T17:13:43.121326Z","end":"2026-09-02T17:13:43.436804Z","steps":["trace[276816397] 'process raft request'  (duration: 116.803883ms)","trace[276816397] 'compare'  (duration: 198.308948ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-02T17:13:43.436958Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T17:13:43.121312Z","time spent":"315.582487ms","remote":"127.0.0.1:51094","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:22189 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-09-02T17:13:43.43702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.706683ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"warn","ts":"2026-09-02T17:13:43.437039Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.018924ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-09-02T17:13:43.43707Z","caller":"traceutil/trace.go:171","msg":"trace[54017735] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:22198; }","duration":"302.796267ms","start":"2026-09-02T17:13:43.134258Z","end":"2026-09-02T17:13:43.437055Z","steps":["trace[54017735] 'agreement among raft nodes before linearized reading'  (duration: 302.625251ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T17:13:43.437135Z","caller":"traceutil/trace.go:171","msg":"trace[1339646050] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:22198; }","duration":"305.178158ms","start":"2026-09-02T17:13:43.131935Z","end":"2026-09-02T17:13:43.437113Z","steps":["trace[1339646050] 'agreement among raft nodes before linearized reading'  (duration: 304.917331ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T17:13:43.43715Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T17:13:43.134244Z","time spent":"302.89098ms","remote":"127.0.0.1:50850","response type":"/etcdserverpb.KV/Range","request count":0,"request size":120,"response count":92,"response size":32,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true "}
{"level":"warn","ts":"2026-09-02T17:13:43.437231Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T17:13:43.131913Z","time spent":"305.300372ms","remote":"127.0.0.1:50998","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":80,"response size":32,"request content":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true "}
{"level":"info","ts":"2026-09-02T17:13:44.889933Z","caller":"traceutil/trace.go:171","msg":"trace[1616017611] transaction","detail":"{read_only:false; response_revision:22200; number_of_response:1; }","duration":"541.581328ms","start":"2026-09-02T17:13:44.348327Z","end":"2026-09-02T17:13:44.889909Z","steps":["trace[1616017611] 'process raft request'  (duration: 541.453844ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T17:13:44.890088Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T17:13:44.348303Z","time spent":"541.716843ms","remote":"127.0.0.1:51094","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:22153 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"info","ts":"2026-09-02T17:13:44.895821Z","caller":"traceutil/trace.go:171","msg":"trace[1595740375] transaction","detail":"{read_only:false; response_revision:22201; number_of_response:1; }","duration":"499.65861ms","start":"2026-09-02T17:13:44.396149Z","end":"2026-09-02T17:13:44.895808Z","steps":["trace[1595740375] 'process raft request'  (duration: 499.399871ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T17:13:44.895891Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T17:13:44.396124Z","time spent":"499.728222ms","remote":"127.0.0.1:51094","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:22191 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"info","ts":"2026-09-02T17:13:44.895978Z","caller":"traceutil/trace.go:171","msg":"trace[1061194899] linearizableReadLoop","detail":"{readStateIndex:22970; appliedIndex:22966; }","duration":"313.847293ms","start":"2026-09-02T17:13:44.582115Z","end":"2026-09-02T17:13:44.895962Z","steps":["trace[1061194899] 'read index received'  (duration: 308.047426ms)","trace[1061194899] 'applied index is now lower than readState.Index'  (duration: 5.798877ms)"],"step_count":2}
{"level":"info","ts":"2026-09-02T17:13:44.89601Z","caller":"traceutil/trace.go:171","msg":"trace[1610686476] transaction","detail":"{read_only:false; response_revision:22203; number_of_response:1; }","duration":"454.447262ms","start":"2026-09-02T17:13:44.441553Z","end":"2026-09-02T17:13:44.896001Z","steps":["trace[1610686476] 'process raft request'  (duration: 454.326688ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T17:13:44.896047Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T17:13:44.441532Z","time spent":"454.494294ms","remote":"127.0.0.1:51094","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:22192 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"info","ts":"2026-09-02T17:13:44.896081Z","caller":"traceutil/trace.go:171","msg":"trace[588439849] transaction","detail":"{read_only:false; response_revision:22202; number_of_response:1; }","duration":"483.218139ms","start":"2026-09-02T17:13:44.412844Z","end":"2026-09-02T17:13:44.896062Z","steps":["trace[588439849] 'process raft request'  (duration: 482.828357ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T17:13:44.896082Z","caller":"traceutil/trace.go:171","msg":"trace[1003547609] transaction","detail":"{read_only:false; response_revision:22204; number_of_response:1; }","duration":"454.478533ms","start":"2026-09-02T17:13:44.441563Z","end":"2026-09-02T17:13:44.896042Z","steps":["trace[1003547609] 'process raft request'  (duration: 454.36789ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T17:13:44.896218Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T17:13:44.412803Z","time spent":"483.336173ms","remote":"127.0.0.1:51094","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" mod_revision:22169 > success:<request_put:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" value_size:416 >> failure:<request_range:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" > >"}
{"level":"warn","ts":"2026-09-02T17:13:44.896248Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T17:13:44.441539Z","time spent":"454.611247ms","remote":"127.0.0.1:51094","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:22193 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"warn","ts":"2026-09-02T17:13:44.8963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.173392ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"}
{"level":"info","ts":"2026-09-02T17:13:44.896366Z","caller":"traceutil/trace.go:171","msg":"trace[1951538809] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:22204; }","duration":"314.273995ms","start":"2026-09-02T17:13:44.582073Z","end":"2026-09-02T17:13:44.896347Z","steps":["trace[1951538809] 'agreement among raft nodes before linearized reading'  (duration: 314.062059ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T17:13:44.89641Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T17:13:44.582056Z","time spent":"314.340188ms","remote":"127.0.0.1:51094","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":519,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"info","ts":"2026-09-02T17:13:45.436209Z","caller":"traceutil/trace.go:171","msg":"trace[860496771] linearizableReadLoop","detail":"{readStateIndex:22974; appliedIndex:22973; }","duration":"203.265451ms","start":"2026-09-02T17:13:45.232897Z","end":"2026-09-02T17:13:45.436162Z","steps":["trace[860496771] 'read index received'  (duration: 203.127066ms)","trace[860496771] 'applied index is now lower than readState.Index'  (duration: 137.545µs)"],"step_count":2}
{"level":"info","ts":"2026-09-02T17:13:45.436293Z","caller":"traceutil/trace.go:171","msg":"trace[141096301] transaction","detail":"{read_only:false; response_revision:22208; number_of_response:1; }","duration":"265.761667ms","start":"2026-09-02T17:13:45.170497Z","end":"2026-09-02T17:13:45.436258Z","steps":["trace[141096301] 'process raft request'  (duration: 265.531719ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T17:13:45.436379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.430282ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/nfd.k8s-sigs.io/nodefeatures/\" range_end:\"/registry/nfd.k8s-sigs.io/nodefeatures0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-09-02T17:13:45.436417Z","caller":"traceutil/trace.go:171","msg":"trace[851131316] range","detail":"{range_begin:/registry/nfd.k8s-sigs.io/nodefeatures/; range_end:/registry/nfd.k8s-sigs.io/nodefeatures0; response_count:0; response_revision:22208; }","duration":"196.518245ms","start":"2026-09-02T17:13:45.239885Z","end":"2026-09-02T17:13:45.436403Z","steps":["trace[851131316] 'agreement among raft nodes before linearized reading'  (duration: 196.434802ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T17:13:45.436434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.507888ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/sshkeys/\" range_end:\"/registry/secretgen.k14s.io/sshkeys0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-02T17:13:45.436501Z","caller":"traceutil/trace.go:171","msg":"trace[252191813] range","detail":"{range_begin:/registry/secretgen.k14s.io/sshkeys/; range_end:/registry/secretgen.k14s.io/sshkeys0; response_count:0; response_revision:22208; }","duration":"203.644882ms","start":"2026-09-02T17:13:45.23284Z","end":"2026-09-02T17:13:45.436485Z","steps":["trace[252191813] 'agreement among raft nodes before linearized reading'  (duration: 203.487598ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T17:13:45.669008Z","caller":"traceutil/trace.go:171","msg":"trace[1986188373] linearizableReadLoop","detail":"{readStateIndex:22975; appliedIndex:22974; }","duration":"167.580672ms","start":"2026-09-02T17:13:45.501403Z","end":"2026-09-02T17:13:45.668984Z","steps":["trace[1986188373] 'read index received'  (duration: 164.167508ms)","trace[1986188373] 'applied index is now lower than readState.Index'  (duration: 3.411634ms)"],"step_count":2}
{"level":"info","ts":"2026-09-02T17:13:45.669129Z","caller":"traceutil/trace.go:171","msg":"trace[1822943639] transaction","detail":"{read_only:false; response_revision:22209; number_of_response:1; }","duration":"225.035354ms","start":"2026-09-02T17:13:45.444082Z","end":"2026-09-02T17:13:45.669118Z","steps":["trace[1822943639] 'process raft request'  (duration: 221.481635ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T17:13:45.66936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.921832ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/clusterissuers/\" range_end:\"/registry/cert-manager.io/clusterissuers0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-09-02T17:13:45.669453Z","caller":"traceutil/trace.go:171","msg":"trace[983723245] range","detail":"{range_begin:/registry/cert-manager.io/clusterissuers/; range_end:/registry/cert-manager.io/clusterissuers0; response_count:0; response_revision:22209; }","duration":"168.073166ms","start":"2026-09-02T17:13:45.501358Z","end":"2026-09-02T17:13:45.669431Z","steps":["trace[983723245] 'agreement among raft nodes before linearized reading'  (duration: 167.86703ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T17:14:51.522236Z","caller":"traceutil/trace.go:171","msg":"trace[80397232] transaction","detail":"{read_only:false; response_revision:22813; number_of_response:1; }","duration":"155.73646ms","start":"2026-09-02T17:14:51.366414Z","end":"2026-09-02T17:14:51.52215Z","steps":["trace[80397232] 'process raft request'  (duration: 155.225764ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T17:14:51.939759Z","caller":"traceutil/trace.go:171","msg":"trace[591321405] transaction","detail":"{read_only:false; response_revision:22814; number_of_response:1; }","duration":"503.778186ms","start":"2026-09-02T17:14:51.435938Z","end":"2026-09-02T17:14:51.939716Z","steps":["trace[591321405] 'process raft request'  (duration: 503.349783ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T17:14:51.939882Z","caller":"traceutil/trace.go:171","msg":"trace[1962345844] transaction","detail":"{read_only:false; response_revision:22816; number_of_response:1; }","duration":"142.186866ms","start":"2026-09-02T17:14:51.797664Z","end":"2026-09-02T17:14:51.939851Z","steps":["trace[1962345844] 'process raft request'  (duration: 142.104664ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T17:14:51.939988Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T17:14:51.43591Z","time spent":"503.953142ms","remote":"127.0.0.1:51094","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:22805 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"info","ts":"2026-09-02T17:14:51.940092Z","caller":"traceutil/trace.go:171","msg":"trace[669380991] transaction","detail":"{read_only:false; response_revision:22815; number_of_response:1; }","duration":"492.502023ms","start":"2026-09-02T17:14:51.447564Z","end":"2026-09-02T17:14:51.940066Z","steps":["trace[669380991] 'process raft request'  (duration: 492.049789ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T17:14:51.940375Z","caller":"traceutil/trace.go:171","msg":"trace[684352236] linearizableReadLoop","detail":"{readStateIndex:23606; appliedIndex:23602; }","duration":"449.462879ms","start":"2026-09-02T17:14:51.490833Z","end":"2026-09-02T17:14:51.940296Z","steps":["trace[684352236] 'read index received'  (duration: 30.942475ms)","trace[684352236] 'applied index is now lower than readState.Index'  (duration: 418.517114ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-02T17:14:51.940585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"449.759169ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"}
{"level":"info","ts":"2026-09-02T17:14:51.940634Z","caller":"traceutil/trace.go:171","msg":"trace[75075303] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:22816; }","duration":"449.847702ms","start":"2026-09-02T17:14:51.490774Z","end":"2026-09-02T17:14:51.940621Z","steps":["trace[75075303] 'agreement among raft nodes before linearized reading'  (duration: 449.682907ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T17:14:51.940664Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T17:14:51.490759Z","time spent":"449.897913ms","remote":"127.0.0.1:51094","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":506,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-09-02T17:14:51.94069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"391.506312ms","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-09-02T17:14:51.940816Z","caller":"traceutil/trace.go:171","msg":"trace[2110737193] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:22816; }","duration":"391.713279ms","start":"2026-09-02T17:14:51.549091Z","end":"2026-09-02T17:14:51.940804Z","steps":["trace[2110737193] 'agreement among raft nodes before linearized reading'  (duration: 391.42498ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T17:14:51.940849Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T17:14:51.549063Z","time spent":"391.776081ms","remote":"127.0.0.1:51094","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":533,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-09-02T17:14:51.941072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.841663ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"}
{"level":"info","ts":"2026-09-02T17:14:51.941109Z","caller":"traceutil/trace.go:171","msg":"trace[476606543] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:22816; }","duration":"274.923165ms","start":"2026-09-02T17:14:51.666175Z","end":"2026-09-02T17:14:51.941098Z","steps":["trace[476606543] 'agreement among raft nodes before linearized reading'  (duration: 274.821242ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T17:14:51.941423Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T17:14:51.447536Z","time spent":"492.650947ms","remote":"127.0.0.1:51094","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:22806 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-09-02T17:14:52.381518Z","caller":"traceutil/trace.go:171","msg":"trace[905079600] linearizableReadLoop","detail":"{readStateIndex:23612; appliedIndex:23611; }","duration":"102.263011ms","start":"2026-09-02T17:14:52.27923Z","end":"2026-09-02T17:14:52.381493Z","steps":["trace[905079600] 'read index received'  (duration: 102.035283ms)","trace[905079600] 'applied index is now lower than readState.Index'  (duration: 226.878µs)"],"step_count":2}
{"level":"warn","ts":"2026-09-02T17:14:52.381775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.513338ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclusters/openstack/ceph\" ","response":"range_response_count:1 size:7914"}
{"level":"info","ts":"2026-09-02T17:14:52.381841Z","caller":"traceutil/trace.go:171","msg":"trace[1170397134] range","detail":"{range_begin:/registry/ceph.rook.io/cephclusters/openstack/ceph; range_end:; response_count:1; response_revision:22821; }","duration":"102.615711ms","start":"2026-09-02T17:14:52.279215Z","end":"2026-09-02T17:14:52.381831Z","steps":["trace[1170397134] 'agreement among raft nodes before linearized reading'  (duration: 102.378544ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T17:14:52.382267Z","caller":"traceutil/trace.go:171","msg":"trace[443333220] transaction","detail":"{read_only:false; response_revision:22821; number_of_response:1; }","duration":"103.868538ms","start":"2026-09-02T17:14:52.278386Z","end":"2026-09-02T17:14:52.382254Z","steps":["trace[443333220] 'process raft request'  (duration: 102.95935ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T17:14:54.055971Z","caller":"traceutil/trace.go:171","msg":"trace[1090856386] transaction","detail":"{read_only:false; response_revision:22829; number_of_response:1; }","duration":"109.49975ms","start":"2026-09-02T17:14:53.946439Z","end":"2026-09-02T17:14:54.055938Z","steps":["trace[1090856386] 'process raft request'  (duration: 54.807092ms)","trace[1090856386] 'compare'  (duration: 54.066379ms)"],"step_count":2}
{"level":"info","ts":"2026-09-02T17:16:53.119006Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":21605}
{"level":"info","ts":"2026-09-02T17:16:53.243709Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":21605,"took":"120.843899ms","hash":3627280346,"current-db-size-bytes":57520128,"current-db-size":"58 MB","current-db-size-in-use-bytes":29802496,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-09-02T17:16:53.243776Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3627280346,"revision":21605,"compact-revision":19167}
{"level":"info","ts":"2026-09-02T17:17:02.770513Z","caller":"traceutil/trace.go:171","msg":"trace[2127292923] transaction","detail":"{read_only:false; response_revision:23706; number_of_response:1; }","duration":"186.938888ms","start":"2026-09-02T17:17:02.583546Z","end":"2026-09-02T17:17:02.770485Z","steps":["trace[2127292923] 'process raft request'  (duration: 186.760342ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T17:18:11.587676Z","caller":"traceutil/trace.go:171","msg":"trace[1413853374] transaction","detail":"{read_only:false; response_revision:24825; number_of_response:1; }","duration":"136.855588ms","start":"2026-09-02T17:18:11.450796Z","end":"2026-09-02T17:18:11.587651Z","steps":["trace[1413853374] 'process raft request'  (duration: 136.693033ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T17:18:11.6156Z","caller":"traceutil/trace.go:171","msg":"trace[199476115] transaction","detail":"{read_only:false; response_revision:24826; number_of_response:1; }","duration":"160.893112ms","start":"2026-09-02T17:18:11.454681Z","end":"2026-09-02T17:18:11.615574Z","steps":["trace[199476115] 'process raft request'  (duration: 160.717527ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T17:18:12.007105Z","caller":"traceutil/trace.go:171","msg":"trace[72505514] linearizableReadLoop","detail":"{readStateIndex:25673; appliedIndex:25672; }","duration":"314.021647ms","start":"2026-09-02T17:18:11.69305Z","end":"2026-09-02T17:18:12.007071Z","steps":["trace[72505514] 'read index received'  (duration: 288.57104ms)","trace[72505514] 'applied index is now lower than readState.Index'  (duration: 25.448877ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-02T17:18:12.007384Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.321476ms","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-09-02T17:18:12.00743Z","caller":"traceutil/trace.go:171","msg":"trace[1091154640] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24827; }","duration":"314.419489ms","start":"2026-09-02T17:18:11.692998Z","end":"2026-09-02T17:18:12.007417Z","steps":["trace[1091154640] 'agreement among raft nodes before linearized reading'  (duration: 314.239703ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T17:18:12.007466Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T17:18:11.692955Z","time spent":"314.502162ms","remote":"127.0.0.1:51094","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":"info","ts":"2026-09-02T17:19:32.669232Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-00000000000067c9.wal"}
{"level":"warn","ts":"2026-09-02T17:20:34.098352Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.654626ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusterrestores/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterrestores0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-02T17:20:34.098445Z","caller":"traceutil/trace.go:171","msg":"trace[1263102604] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusterrestores/; range_end:/registry/pxc.percona.com/perconaxtradbclusterrestores0; response_count:0; response_revision:26199; }","duration":"143.781209ms","start":"2026-09-02T17:20:33.954644Z","end":"2026-09-02T17:20:34.098425Z","steps":["trace[1263102604] 'count revisions from in-memory index tree'  (duration: 143.514281ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T17:20:48.049477Z","caller":"traceutil/trace.go:171","msg":"trace[1489099803] transaction","detail":"{read_only:false; response_revision:26304; number_of_response:1; }","duration":"102.22729ms","start":"2026-09-02T17:20:47.947223Z","end":"2026-09-02T17:20:48.049451Z","steps":["trace[1489099803] 'process raft request'  (duration: 102.094316ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T17:21:06.477858Z","caller":"traceutil/trace.go:171","msg":"trace[437892020] transaction","detail":"{read_only:false; response_revision:26440; number_of_response:1; }","duration":"112.539856ms","start":"2026-09-02T17:21:06.365288Z","end":"2026-09-02T17:21:06.477827Z","steps":["trace[437892020] 'process raft request'  (duration: 112.33788ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T17:21:53.125442Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":23627}
{"level":"info","ts":"2026-09-02T17:21:53.251144Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":23627,"took":"121.86187ms","hash":89646404,"current-db-size-bytes":57520128,"current-db-size":"58 MB","current-db-size-in-use-bytes":43343872,"current-db-size-in-use":"43 MB"}
{"level":"info","ts":"2026-09-02T17:21:53.251217Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":89646404,"revision":23627,"compact-revision":21605}
{"level":"info","ts":"2026-09-02T17:26:53.132049Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":26788}
{"level":"info","ts":"2026-09-02T17:26:53.277515Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":26788,"took":"141.562821ms","hash":3757795834,"current-db-size-bytes":57520128,"current-db-size":"58 MB","current-db-size-in-use-bytes":31670272,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-09-02T17:26:53.277652Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3757795834,"revision":26788,"compact-revision":23627}
{"level":"warn","ts":"2026-09-02T17:26:53.859991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.100482ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/pxc-operator-69cb5bbdb9-76s74\" ","response":"range_response_count:1 size:4349"}
{"level":"info","ts":"2026-09-02T17:26:53.860188Z","caller":"traceutil/trace.go:171","msg":"trace[1713504820] range","detail":"{range_begin:/registry/pods/openstack/pxc-operator-69cb5bbdb9-76s74; range_end:; response_count:1; response_revision:29024; }","duration":"116.32739ms","start":"2026-09-02T17:26:53.743835Z","end":"2026-09-02T17:26:53.860163Z","steps":["trace[1713504820] 'range keys from in-memory index tree'  (duration: 115.945608ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-02T17:26:53.86023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.722449ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/placement-ks-user-25qfm\" ","response":"range_response_count:1 size:9258"}
{"level":"info","ts":"2026-09-02T17:26:53.860339Z","caller":"traceutil/trace.go:171","msg":"trace[1942770798] range","detail":"{range_begin:/registry/pods/openstack/placement-ks-user-25qfm; range_end:; response_count:1; response_revision:29024; }","duration":"146.875494ms","start":"2026-09-02T17:26:53.713442Z","end":"2026-09-02T17:26:53.860317Z","steps":["trace[1942770798] 'range keys from in-memory index tree'  (duration: 146.561134ms)"],"step_count":1}
{"level":"info","ts":"2026-09-02T17:26:55.598232Z","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-09-02T17:26:55.603868Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003}
{"level":"info","ts":"2026-09-02T17:26:55.603995Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003}