{"level":"warn","ts":"2026-09-01T18:30:20.021698Z","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-01T18:30:20.021858Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.105: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.105:2380","--initial-cluster=instance=https://162.253.55.105:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.105:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.105: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-01T18:30:20.021968Z","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-01T18:30:20.021992Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.105:2380"]}
{"level":"info","ts":"2026-09-01T18:30:20.022031Z","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-01T18:30:20.022998Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.105:2379"]}
{"level":"info","ts":"2026-09-01T18:30:20.023128Z","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.105:2380"],"listen-peer-urls":["https://162.253.55.105:2380"],"advertise-client-urls":["https://162.253.55.105:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.105:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.105: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-01T18:30:20.026463Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.948445ms"}
{"level":"info","ts":"2026-09-01T18:30:20.032717Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"15a19459cc268924","cluster-id":"9aaad1c0fc15509e"}
{"level":"info","ts":"2026-09-01T18:30:20.032808Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"15a19459cc268924 switched to configuration voters=()"}
{"level":"info","ts":"2026-09-01T18:30:20.032831Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"15a19459cc268924 became follower at term 0"}
{"level":"info","ts":"2026-09-01T18:30:20.032842Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 15a19459cc268924 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-09-01T18:30:20.032857Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"15a19459cc268924 became follower at term 1"}
{"level":"info","ts":"2026-09-01T18:30:20.032904Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"15a19459cc268924 switched to configuration voters=(1558690059444980004)"}
{"level":"warn","ts":"2026-09-01T18:30:20.040238Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-09-01T18:30:20.042113Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-09-01T18:30:20.043972Z","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-01T18:30:20.047048Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"15a19459cc268924","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-09-01T18:30:20.047282Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"15a19459cc268924","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-09-01T18:30:20.047388Z","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-01T18:30:20.047537Z","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-01T18:30:20.047557Z","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-01T18:30:20.05016Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"15a19459cc268924 switched to configuration voters=(1558690059444980004)"}
{"level":"info","ts":"2026-09-01T18:30:20.050527Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"9aaad1c0fc15509e","local-member-id":"15a19459cc268924","added-peer-id":"15a19459cc268924","added-peer-peer-urls":["https://162.253.55.105:2380"]}
{"level":"info","ts":"2026-09-01T18:30:20.052521Z","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-01T18:30:20.052682Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.105:2380"}
{"level":"info","ts":"2026-09-01T18:30:20.052811Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.105:2380"}
{"level":"info","ts":"2026-09-01T18:30:20.052876Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"15a19459cc268924","initial-advertise-peer-urls":["https://162.253.55.105:2380"],"listen-peer-urls":["https://162.253.55.105:2380"],"advertise-client-urls":["https://162.253.55.105:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.105:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-09-01T18:30:20.052941Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-09-01T18:30:20.634023Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"15a19459cc268924 is starting a new election at term 1"}
{"level":"info","ts":"2026-09-01T18:30:20.634143Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"15a19459cc268924 became pre-candidate at term 1"}
{"level":"info","ts":"2026-09-01T18:30:20.634179Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"15a19459cc268924 received MsgPreVoteResp from 15a19459cc268924 at term 1"}
{"level":"info","ts":"2026-09-01T18:30:20.634203Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"15a19459cc268924 became candidate at term 2"}
{"level":"info","ts":"2026-09-01T18:30:20.634221Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"15a19459cc268924 received MsgVoteResp from 15a19459cc268924 at term 2"}
{"level":"info","ts":"2026-09-01T18:30:20.634239Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"15a19459cc268924 became leader at term 2"}
{"level":"info","ts":"2026-09-01T18:30:20.634281Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 15a19459cc268924 elected leader 15a19459cc268924 at term 2"}
{"level":"info","ts":"2026-09-01T18:30:20.635719Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"15a19459cc268924","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.105:2379]}","request-path":"/0/members/15a19459cc268924/attributes","cluster-id":"9aaad1c0fc15509e","publish-timeout":"7s"}
{"level":"info","ts":"2026-09-01T18:30:20.635766Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-09-01T18:30:20.635732Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-09-01T18:30:20.635844Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-09-01T18:30:20.636051Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-09-01T18:30:20.636134Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-09-01T18:30:20.636891Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"9aaad1c0fc15509e","local-member-id":"15a19459cc268924","cluster-version":"3.5"}
{"level":"info","ts":"2026-09-01T18:30:20.637032Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-09-01T18:30:20.637068Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-09-01T18:30:20.638156Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-09-01T18:30:20.640497Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.105:2379"}
{"level":"info","ts":"2026-09-01T18:30:25.985555Z","caller":"traceutil/trace.go:171","msg":"trace[1784834807] transaction","detail":"{read_only:false; response_revision:280; number_of_response:1; }","duration":"104.116279ms","start":"2026-09-01T18:30:25.881411Z","end":"2026-09-01T18:30:25.985527Z","steps":["trace[1784834807] 'process raft request'  (duration: 103.971485ms)"],"step_count":1}
{"level":"info","ts":"2026-09-01T18:30:25.985684Z","caller":"traceutil/trace.go:171","msg":"trace[1668008425] transaction","detail":"{read_only:false; response_revision:279; number_of_response:1; }","duration":"106.458506ms","start":"2026-09-01T18:30:25.8792Z","end":"2026-09-01T18:30:25.985658Z","steps":["trace[1668008425] 'process raft request'  (duration: 97.580179ms)"],"step_count":1}
{"level":"info","ts":"2026-09-01T18:30:36.543583Z","caller":"traceutil/trace.go:171","msg":"trace[945455510] transaction","detail":"{read_only:false; response_revision:405; number_of_response:1; }","duration":"491.931826ms","start":"2026-09-01T18:30:36.051617Z","end":"2026-09-01T18:30:36.543549Z","steps":["trace[945455510] 'process raft request'  (duration: 491.792722ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-01T18:30:36.544233Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T18:30:36.051592Z","time spent":"492.082931ms","remote":"127.0.0.1:55582","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5149,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/etcd-instance\" mod_revision:402 > success:<request_put:<key:\"/registry/pods/kube-system/etcd-instance\" value_size:5101 >> failure:<request_range:<key:\"/registry/pods/kube-system/etcd-instance\" > >"}
{"level":"info","ts":"2026-09-01T18:30:36.771425Z","caller":"traceutil/trace.go:171","msg":"trace[915474609] linearizableReadLoop","detail":"{readStateIndex:421; appliedIndex:419; }","duration":"429.953475ms","start":"2026-09-01T18:30:36.34144Z","end":"2026-09-01T18:30:36.771393Z","steps":["trace[915474609] 'read index received'  (duration: 201.917355ms)","trace[915474609] 'applied index is now lower than readState.Index'  (duration: 228.03508ms)"],"step_count":2}
{"level":"info","ts":"2026-09-01T18:30:36.771678Z","caller":"traceutil/trace.go:171","msg":"trace[2091445397] transaction","detail":"{read_only:false; response_revision:407; number_of_response:1; }","duration":"400.085162ms","start":"2026-09-01T18:30:36.371559Z","end":"2026-09-01T18:30:36.771644Z","steps":["trace[2091445397] 'process raft request'  (duration: 399.779184ms)"],"step_count":1}
{"level":"info","ts":"2026-09-01T18:30:36.771768Z","caller":"traceutil/trace.go:171","msg":"trace[1255910920] transaction","detail":"{read_only:false; response_revision:406; number_of_response:1; }","duration":"656.518434ms","start":"2026-09-01T18:30:36.115213Z","end":"2026-09-01T18:30:36.771731Z","steps":["trace[1255910920] 'process raft request'  (duration: 652.715204ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-01T18:30:36.77178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"429.955035ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"warn","ts":"2026-09-01T18:30:36.771781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"430.336427ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-09-01T18:30:36.771845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"384.45548ms","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-01T18:30:36.771886Z","caller":"traceutil/trace.go:171","msg":"trace[923017077] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:407; }","duration":"430.133161ms","start":"2026-09-01T18:30:36.341738Z","end":"2026-09-01T18:30:36.771872Z","steps":["trace[923017077] 'agreement among raft nodes before linearized reading'  (duration: 429.926685ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-01T18:30:36.771879Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T18:30:36.37154Z","time spent":"400.245277ms","remote":"127.0.0.1:55674","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:283 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"info","ts":"2026-09-01T18:30:36.771909Z","caller":"traceutil/trace.go:171","msg":"trace[1055434247] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:407; }","duration":"430.513051ms","start":"2026-09-01T18:30:36.341372Z","end":"2026-09-01T18:30:36.771885Z","steps":["trace[1055434247] 'agreement among raft nodes before linearized reading'  (duration: 430.321746ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-01T18:30:36.771935Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T18:30:36.341725Z","time spent":"430.201922ms","remote":"127.0.0.1:55674","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-09-01T18:30:36.771914Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T18:30:36.115172Z","time spent":"656.679628ms","remote":"127.0.0.1:55576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4402,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:348 > success:<request_put:<key:\"/registry/minions/instance\" value_size:4368 >> failure:<request_range:<key:\"/registry/minions/instance\" > >"}
{"level":"warn","ts":"2026-09-01T18:30:36.771951Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T18:30:36.341345Z","time spent":"430.595154ms","remote":"127.0.0.1:55394","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-09-01T18:30:36.77196Z","caller":"traceutil/trace.go:171","msg":"trace[1718206762] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:407; }","duration":"384.587084ms","start":"2026-09-01T18:30:36.387328Z","end":"2026-09-01T18:30:36.771915Z","steps":["trace[1718206762] 'agreement among raft nodes before linearized reading'  (duration: 384.385268ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-01T18:30:36.772012Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T18:30:36.387317Z","time spent":"384.686157ms","remote":"127.0.0.1:55674","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-01T18:31:12.622617Z","caller":"traceutil/trace.go:171","msg":"trace[1346587613] transaction","detail":"{read_only:false; response_revision:649; number_of_response:1; }","duration":"264.591297ms","start":"2026-09-01T18:31:12.357998Z","end":"2026-09-01T18:31:12.622589Z","steps":["trace[1346587613] 'process raft request'  (duration: 264.472523ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-01T18:31:13.251673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.386215ms","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-01T18:31:13.251789Z","caller":"traceutil/trace.go:171","msg":"trace[1405997448] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:649; }","duration":"288.565191ms","start":"2026-09-01T18:31:12.963198Z","end":"2026-09-01T18:31:13.251763Z","steps":["trace[1405997448] 'range keys from in-memory index tree'  (duration: 288.266481ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-01T18:31:13.252087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.741436ms","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-01T18:31:13.252185Z","caller":"traceutil/trace.go:171","msg":"trace[502309453] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:649; }","duration":"287.86932ms","start":"2026-09-01T18:31:12.96429Z","end":"2026-09-01T18:31:13.252159Z","steps":["trace[502309453] 'range keys from in-memory index tree'  (duration: 287.162639ms)"],"step_count":1}
{"level":"info","ts":"2026-09-01T18:31:13.253017Z","caller":"traceutil/trace.go:171","msg":"trace[774880628] transaction","detail":"{read_only:false; response_revision:650; number_of_response:1; }","duration":"225.289151ms","start":"2026-09-01T18:31:13.027713Z","end":"2026-09-01T18:31:13.253002Z","steps":["trace[774880628] 'process raft request'  (duration: 220.574145ms)"],"step_count":1}
{"level":"info","ts":"2026-09-01T18:32:06.119561Z","caller":"traceutil/trace.go:171","msg":"trace[57941366] transaction","detail":"{read_only:false; response_revision:1250; number_of_response:1; }","duration":"110.673538ms","start":"2026-09-01T18:32:06.008861Z","end":"2026-09-01T18:32:06.119535Z","steps":["trace[57941366] 'process raft request'  (duration: 110.514054ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-01T18:32:28.750201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.126062ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-01T18:32:28.750311Z","caller":"traceutil/trace.go:171","msg":"trace[789422949] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1508; }","duration":"110.297107ms","start":"2026-09-01T18:32:28.639986Z","end":"2026-09-01T18:32:28.750283Z","steps":["trace[789422949] 'range keys from in-memory index tree'  (duration: 110.04597ms)"],"step_count":1}
{"level":"info","ts":"2026-09-01T18:32:28.750441Z","caller":"traceutil/trace.go:171","msg":"trace[1580770344] transaction","detail":"{read_only:false; response_revision:1509; number_of_response:1; }","duration":"109.873515ms","start":"2026-09-01T18:32:28.640533Z","end":"2026-09-01T18:32:28.750407Z","steps":["trace[1580770344] 'process raft request'  (duration: 83.819893ms)","trace[1580770344] 'compare'  (duration: 25.811795ms)"],"step_count":2}
{"level":"info","ts":"2026-09-01T18:32:56.008121Z","caller":"traceutil/trace.go:171","msg":"trace[550706341] transaction","detail":"{read_only:false; response_revision:1936; number_of_response:1; }","duration":"130.0861ms","start":"2026-09-01T18:32:55.878007Z","end":"2026-09-01T18:32:56.008093Z","steps":["trace[550706341] 'process raft request'  (duration: 129.916025ms)"],"step_count":1}
{"level":"info","ts":"2026-09-01T18:32:56.064827Z","caller":"traceutil/trace.go:171","msg":"trace[137079741] transaction","detail":"{read_only:false; response_revision:1937; number_of_response:1; }","duration":"186.711206ms","start":"2026-09-01T18:32:55.878088Z","end":"2026-09-01T18:32:56.064799Z","steps":["trace[137079741] 'process raft request'  (duration: 186.567792ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-01T18:33:10.08792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.501027ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9882199808960532865 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/endpointslices/openstack/rabbitmq-messaging-topology-operator-webhook-wrgcd\" mod_revision:1772 > success:<request_put:<key:\"/registry/endpointslices/openstack/rabbitmq-messaging-topology-operator-webhook-wrgcd\" value_size:1752 >> failure:<request_range:<key:\"/registry/endpointslices/openstack/rabbitmq-messaging-topology-operator-webhook-wrgcd\" > >>","response":"size:16"}
{"level":"info","ts":"2026-09-01T18:33:10.088152Z","caller":"traceutil/trace.go:171","msg":"trace[743297045] transaction","detail":"{read_only:false; response_revision:2052; number_of_response:1; }","duration":"181.68099ms","start":"2026-09-01T18:33:09.90642Z","end":"2026-09-01T18:33:10.088101Z","steps":["trace[743297045] 'process raft request'  (duration: 46.351249ms)","trace[743297045] 'compare'  (duration: 133.836278ms)"],"step_count":2}
{"level":"info","ts":"2026-09-01T18:33:10.150995Z","caller":"traceutil/trace.go:171","msg":"trace[132141833] transaction","detail":"{read_only:false; response_revision:2053; number_of_response:1; }","duration":"244.31882ms","start":"2026-09-01T18:33:09.90663Z","end":"2026-09-01T18:33:10.150948Z","steps":["trace[132141833] 'process raft request'  (duration: 244.049393ms)"],"step_count":1}
{"level":"info","ts":"2026-09-01T18:33:10.151244Z","caller":"traceutil/trace.go:171","msg":"trace[1661647443] transaction","detail":"{read_only:false; response_revision:2054; number_of_response:1; }","duration":"242.639932ms","start":"2026-09-01T18:33:09.908561Z","end":"2026-09-01T18:33:10.151201Z","steps":["trace[1661647443] 'process raft request'  (duration: 242.289142ms)"],"step_count":1}
{"level":"info","ts":"2026-09-01T18:33:10.267974Z","caller":"traceutil/trace.go:171","msg":"trace[530831190] transaction","detail":"{read_only:false; response_revision:2055; number_of_response:1; }","duration":"111.954555ms","start":"2026-09-01T18:33:10.155893Z","end":"2026-09-01T18:33:10.267847Z","steps":["trace[530831190] 'process raft request'  (duration: 111.75764ms)"],"step_count":1}
{"level":"info","ts":"2026-09-01T18:33:10.304851Z","caller":"traceutil/trace.go:171","msg":"trace[1072269576] transaction","detail":"{read_only:false; response_revision:2056; number_of_response:1; }","duration":"148.880672ms","start":"2026-09-01T18:33:10.15594Z","end":"2026-09-01T18:33:10.30482Z","steps":["trace[1072269576] 'process raft request'  (duration: 148.624415ms)"],"step_count":1}
{"level":"info","ts":"2026-09-01T18:33:10.304963Z","caller":"traceutil/trace.go:171","msg":"trace[2001328816] transaction","detail":"{read_only:false; response_revision:2057; number_of_response:1; }","duration":"144.183988ms","start":"2026-09-01T18:33:10.160752Z","end":"2026-09-01T18:33:10.304936Z","steps":["trace[2001328816] 'process raft request'  (duration: 143.999152ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-01T18:33:46.799768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.306909ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9882199808960533391 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:2245 > 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:16"}
{"level":"info","ts":"2026-09-01T18:33:46.799976Z","caller":"traceutil/trace.go:171","msg":"trace[657528096] transaction","detail":"{read_only:false; response_revision:2255; number_of_response:1; }","duration":"297.243551ms","start":"2026-09-01T18:33:46.502699Z","end":"2026-09-01T18:33:46.799942Z","steps":["trace[657528096] 'process raft request'  (duration: 141.623383ms)","trace[657528096] 'compare'  (duration: 155.084712ms)"],"step_count":2}
{"level":"info","ts":"2026-09-01T18:33:46.813973Z","caller":"traceutil/trace.go:171","msg":"trace[701236799] transaction","detail":"{read_only:false; response_revision:2256; number_of_response:1; }","duration":"172.266358ms","start":"2026-09-01T18:33:46.641673Z","end":"2026-09-01T18:33:46.81394Z","steps":["trace[701236799] 'process raft request'  (duration: 172.115104ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-01T18:33:47.051677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.566974ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9882199808960533393 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" mod_revision:2221 > 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:16"}
{"level":"info","ts":"2026-09-01T18:33:47.052142Z","caller":"traceutil/trace.go:171","msg":"trace[963778259] transaction","detail":"{read_only:false; response_revision:2258; number_of_response:1; }","duration":"340.916803ms","start":"2026-09-01T18:33:46.711172Z","end":"2026-09-01T18:33:47.052089Z","steps":["trace[963778259] 'process raft request'  (duration: 340.642045ms)"],"step_count":1}
{"level":"info","ts":"2026-09-01T18:33:47.052243Z","caller":"traceutil/trace.go:171","msg":"trace[829071725] linearizableReadLoop","detail":"{readStateIndex:2345; appliedIndex:2343; }","duration":"344.720232ms","start":"2026-09-01T18:33:46.707502Z","end":"2026-09-01T18:33:47.052223Z","steps":["trace[829071725] 'read index received'  (duration: 106.193049ms)","trace[829071725] 'applied index is now lower than readState.Index'  (duration: 238.526193ms)"],"step_count":2}
{"level":"info","ts":"2026-09-01T18:33:47.052396Z","caller":"traceutil/trace.go:171","msg":"trace[749051337] transaction","detail":"{read_only:false; response_revision:2257; number_of_response:1; }","duration":"392.680119ms","start":"2026-09-01T18:33:46.659693Z","end":"2026-09-01T18:33:47.052374Z","steps":["trace[749051337] 'process raft request'  (duration: 244.254569ms)","trace[749051337] 'compare'  (duration: 147.338888ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-01T18:33:47.052462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.95902ms","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-01T18:33:47.052504Z","caller":"traceutil/trace.go:171","msg":"trace[1413957112] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2259; }","duration":"345.051783ms","start":"2026-09-01T18:33:46.707439Z","end":"2026-09-01T18:33:47.052491Z","steps":["trace[1413957112] 'agreement among raft nodes before linearized reading'  (duration: 344.895539ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-01T18:33:47.052539Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T18:33:46.70742Z","time spent":"345.110874ms","remote":"127.0.0.1:55674","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-09-01T18:33:47.052667Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T18:33:46.711157Z","time spent":"341.077567ms","remote":"127.0.0.1:55674","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:2248 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"warn","ts":"2026-09-01T18:33:47.05292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.412821ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-01T18:33:47.053058Z","caller":"traceutil/trace.go:171","msg":"trace[627372822] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:2259; }","duration":"220.655177ms","start":"2026-09-01T18:33:46.832372Z","end":"2026-09-01T18:33:47.053027Z","steps":["trace[627372822] 'agreement among raft nodes before linearized reading'  (duration: 220.380949ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-01T18:33:47.053147Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T18:33:46.659673Z","time spent":"392.846104ms","remote":"127.0.0.1:55674","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" mod_revision:2221 > 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-01T18:33:47.05317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.865055ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"}
{"level":"info","ts":"2026-09-01T18:33:47.053419Z","caller":"traceutil/trace.go:171","msg":"trace[490453518] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2259; }","duration":"274.066751ms","start":"2026-09-01T18:33:46.779232Z","end":"2026-09-01T18:33:47.053299Z","steps":["trace[490453518] 'agreement among raft nodes before linearized reading'  (duration: 273.460604ms)"],"step_count":1}
{"level":"info","ts":"2026-09-01T18:33:47.213995Z","caller":"traceutil/trace.go:171","msg":"trace[938866032] transaction","detail":"{read_only:false; response_revision:2260; number_of_response:1; }","duration":"155.838993ms","start":"2026-09-01T18:33:47.058127Z","end":"2026-09-01T18:33:47.213966Z","steps":["trace[938866032] 'process raft request'  (duration: 144.068614ms)","trace[938866032] 'compare'  (duration: 11.515052ms)"],"step_count":2}
{"level":"info","ts":"2026-09-01T18:33:47.214457Z","caller":"traceutil/trace.go:171","msg":"trace[1622915679] transaction","detail":"{read_only:false; response_revision:2261; number_of_response:1; }","duration":"155.394301ms","start":"2026-09-01T18:33:47.059027Z","end":"2026-09-01T18:33:47.214421Z","steps":["trace[1622915679] 'process raft request'  (duration: 154.856516ms)"],"step_count":1}
{"level":"info","ts":"2026-09-01T18:33:47.214426Z","caller":"traceutil/trace.go:171","msg":"trace[1439897682] transaction","detail":"{read_only:false; response_revision:2262; number_of_response:1; }","duration":"155.06917ms","start":"2026-09-01T18:33:47.059319Z","end":"2026-09-01T18:33:47.214388Z","steps":["trace[1439897682] 'process raft request'  (duration: 154.905286ms)"],"step_count":1}
{"level":"info","ts":"2026-09-01T18:39:53.802195Z","caller":"traceutil/trace.go:171","msg":"trace[2106543138] transaction","detail":"{read_only:false; response_revision:5296; number_of_response:1; }","duration":"214.302247ms","start":"2026-09-01T18:39:53.587872Z","end":"2026-09-01T18:39:53.802175Z","steps":["trace[2106543138] 'process raft request'  (duration: 214.180903ms)"],"step_count":1}
{"level":"info","ts":"2026-09-01T18:40:03.492423Z","caller":"traceutil/trace.go:171","msg":"trace[846170094] linearizableReadLoop","detail":"{readStateIndex:5715; appliedIndex:5714; }","duration":"102.302204ms","start":"2026-09-01T18:40:03.390095Z","end":"2026-09-01T18:40:03.492397Z","steps":["trace[846170094] 'read index received'  (duration: 69.050864ms)","trace[846170094] 'applied index is now lower than readState.Index'  (duration: 33.25031ms)"],"step_count":2}
{"level":"info","ts":"2026-09-01T18:40:03.492729Z","caller":"traceutil/trace.go:171","msg":"trace[2142680557] transaction","detail":"{read_only:false; response_revision:5504; number_of_response:1; }","duration":"110.825297ms","start":"2026-09-01T18:40:03.381889Z","end":"2026-09-01T18:40:03.492714Z","steps":["trace[2142680557] 'process raft request'  (duration: 77.343401ms)","trace[2142680557] 'compare'  (duration: 32.93588ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-01T18:40:03.493008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.899581ms","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-01T18:40:03.493038Z","caller":"traceutil/trace.go:171","msg":"trace[493291787] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5504; }","duration":"102.966344ms","start":"2026-09-01T18:40:03.390063Z","end":"2026-09-01T18:40:03.49303Z","steps":["trace[493291787] 'agreement among raft nodes before linearized reading'  (duration: 102.82976ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-01T18:40:09.037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.560977ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9882199808960541554 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/services/specs/openstack/memcached-metrics\" mod_revision:0 > success:<request_put:<key:\"/registry/services/specs/openstack/memcached-metrics\" value_size:688 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-09-01T18:40:09.037123Z","caller":"traceutil/trace.go:171","msg":"trace[825672142] linearizableReadLoop","detail":"{readStateIndex:5797; appliedIndex:5796; }","duration":"270.951263ms","start":"2026-09-01T18:40:08.766154Z","end":"2026-09-01T18:40:09.037105Z","steps":["trace[825672142] 'read index received'  (duration: 102.16198ms)","trace[825672142] 'applied index is now lower than readState.Index'  (duration: 168.788123ms)"],"step_count":2}
{"level":"info","ts":"2026-09-01T18:40:09.037163Z","caller":"traceutil/trace.go:171","msg":"trace[1453981714] transaction","detail":"{read_only:false; response_revision:5584; number_of_response:1; }","duration":"277.348862ms","start":"2026-09-01T18:40:08.759765Z","end":"2026-09-01T18:40:09.037114Z","steps":["trace[1453981714] 'process raft request'  (duration: 108.59759ms)","trace[1453981714] 'compare'  (duration: 168.399162ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-01T18:40:09.03731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.821483ms","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":"warn","ts":"2026-09-01T18:40:09.03734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.18436ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"}
{"level":"info","ts":"2026-09-01T18:40:09.037394Z","caller":"traceutil/trace.go:171","msg":"trace[1306948159] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5584; }","duration":"271.268432ms","start":"2026-09-01T18:40:08.766113Z","end":"2026-09-01T18:40:09.037382Z","steps":["trace[1306948159] 'agreement among raft nodes before linearized reading'  (duration: 271.074177ms)"],"step_count":1}
{"level":"info","ts":"2026-09-01T18:40:09.037391Z","caller":"traceutil/trace.go:171","msg":"trace[1883446128] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:5584; }","duration":"170.951467ms","start":"2026-09-01T18:40:08.866423Z","end":"2026-09-01T18:40:09.037374Z","steps":["trace[1883446128] 'agreement among raft nodes before linearized reading'  (duration: 170.781532ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-01T18:40:09.038801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.737555ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:530"}
{"level":"info","ts":"2026-09-01T18:40:09.038867Z","caller":"traceutil/trace.go:171","msg":"trace[711054523] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:5584; }","duration":"111.88763ms","start":"2026-09-01T18:40:08.926964Z","end":"2026-09-01T18:40:09.038851Z","steps":["trace[711054523] 'agreement among raft nodes before linearized reading'  (duration: 110.691204ms)"],"step_count":1}
{"level":"info","ts":"2026-09-01T18:40:18.295276Z","caller":"traceutil/trace.go:171","msg":"trace[1874650709] transaction","detail":"{read_only:false; response_revision:5754; number_of_response:1; }","duration":"146.571841ms","start":"2026-09-01T18:40:18.148677Z","end":"2026-09-01T18:40:18.295249Z","steps":["trace[1874650709] 'process raft request'  (duration: 146.391475ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-01T18:40:18.581276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.123086ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/prometheusrules/\" range_end:\"/registry/monitoring.coreos.com/prometheusrules0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-09-01T18:40:18.581419Z","caller":"traceutil/trace.go:171","msg":"trace[730860009] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheusrules/; range_end:/registry/monitoring.coreos.com/prometheusrules0; response_count:0; response_revision:5755; }","duration":"156.349883ms","start":"2026-09-01T18:40:18.425042Z","end":"2026-09-01T18:40:18.581392Z","steps":["trace[730860009] 'count revisions from in-memory index tree'  (duration: 155.93649ms)"],"step_count":1}
{"level":"info","ts":"2026-09-01T18:40:18.696983Z","caller":"traceutil/trace.go:171","msg":"trace[1241972723] transaction","detail":"{read_only:false; response_revision:5756; number_of_response:1; }","duration":"123.079632ms","start":"2026-09-01T18:40:18.573875Z","end":"2026-09-01T18:40:18.696955Z","steps":["trace[1241972723] 'process raft request'  (duration: 122.895287ms)"],"step_count":1}
{"level":"info","ts":"2026-09-01T18:40:18.859554Z","caller":"traceutil/trace.go:171","msg":"trace[1150916052] linearizableReadLoop","detail":"{readStateIndex:5972; appliedIndex:5970; }","duration":"276.357233ms","start":"2026-09-01T18:40:18.583183Z","end":"2026-09-01T18:40:18.85954Z","steps":["trace[1150916052] 'read index received'  (duration: 113.637251ms)","trace[1150916052] 'applied index is now lower than readState.Index'  (duration: 162.718512ms)"],"step_count":2}
{"level":"info","ts":"2026-09-01T18:40:18.859658Z","caller":"traceutil/trace.go:171","msg":"trace[115229644] transaction","detail":"{read_only:false; response_revision:5757; number_of_response:1; }","duration":"284.554768ms","start":"2026-09-01T18:40:18.575042Z","end":"2026-09-01T18:40:18.859597Z","steps":["trace[115229644] 'process raft request'  (duration: 273.387315ms)","trace[115229644] 'compare'  (duration: 10.971717ms)"],"step_count":2}
{"level":"info","ts":"2026-09-01T18:40:18.859699Z","caller":"traceutil/trace.go:171","msg":"trace[1674136075] transaction","detail":"{read_only:false; response_revision:5758; number_of_response:1; }","duration":"172.385269ms","start":"2026-09-01T18:40:18.68724Z","end":"2026-09-01T18:40:18.859626Z","steps":["trace[1674136075] 'process raft request'  (duration: 172.250775ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-01T18:40:18.859785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.734929ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-01T18:40:18.859812Z","caller":"traceutil/trace.go:171","msg":"trace[11030722] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5758; }","duration":"217.799671ms","start":"2026-09-01T18:40:18.642003Z","end":"2026-09-01T18:40:18.859803Z","steps":["trace[11030722] 'agreement among raft nodes before linearized reading'  (duration: 217.762559ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-01T18:40:18.859742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.556999ms","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-01T18:40:18.859953Z","caller":"traceutil/trace.go:171","msg":"trace[725637918] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5758; }","duration":"276.788735ms","start":"2026-09-01T18:40:18.583107Z","end":"2026-09-01T18:40:18.859896Z","steps":["trace[725637918] 'agreement among raft nodes before linearized reading'  (duration: 276.524218ms)"],"step_count":1}
{"level":"info","ts":"2026-09-01T18:40:20.665071Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2959}
{"level":"info","ts":"2026-09-01T18:40:20.743722Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2959,"took":"77.151756ms","hash":3416301282,"current-db-size-bytes":56750080,"current-db-size":"57 MB","current-db-size-in-use-bytes":32063488,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-09-01T18:40:20.743841Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3416301282,"revision":2959,"compact-revision":-1}
{"level":"info","ts":"2026-09-01T18:40:29.781842Z","caller":"traceutil/trace.go:171","msg":"trace[917750118] transaction","detail":"{read_only:false; response_revision:5918; number_of_response:1; }","duration":"115.492036ms","start":"2026-09-01T18:40:29.666316Z","end":"2026-09-01T18:40:29.781808Z","steps":["trace[917750118] 'process raft request'  (duration: 90.479682ms)","trace[917750118] 'compare'  (duration: 24.904671ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-01T18:41:10.133855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.170182ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9882199808960543270 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:6248 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-09-01T18:41:10.134062Z","caller":"traceutil/trace.go:171","msg":"trace[457615756] transaction","detail":"{read_only:false; response_revision:6270; number_of_response:1; }","duration":"113.665493ms","start":"2026-09-01T18:41:10.020379Z","end":"2026-09-01T18:41:10.134044Z","steps":["trace[457615756] 'process raft request'  (duration: 113.594761ms)"],"step_count":1}
{"level":"info","ts":"2026-09-01T18:41:10.134185Z","caller":"traceutil/trace.go:171","msg":"trace[228413940] linearizableReadLoop","detail":"{readStateIndex:6501; appliedIndex:6500; }","duration":"130.593049ms","start":"2026-09-01T18:41:10.003566Z","end":"2026-09-01T18:41:10.134159Z","steps":["trace[228413940] 'read index received'  (duration: 5.979535ms)","trace[228413940] 'applied index is now lower than readState.Index'  (duration: 124.609764ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-01T18:41:10.134394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.824716ms","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":"warn","ts":"2026-09-01T18:41:10.134382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.062804ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-db-sync\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-01T18:41:10.134458Z","caller":"traceutil/trace.go:171","msg":"trace[703764152] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:6270; }","duration":"130.889208ms","start":"2026-09-01T18:41:10.003531Z","end":"2026-09-01T18:41:10.13442Z","steps":["trace[703764152] 'agreement among raft nodes before linearized reading'  (duration: 130.741504ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-01T18:41:10.134492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.171499ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3684"}
{"level":"info","ts":"2026-09-01T18:41:10.134499Z","caller":"traceutil/trace.go:171","msg":"trace[842865859] range","detail":"{range_begin:/registry/jobs/openstack/keystone-db-sync; range_end:; response_count:0; response_revision:6270; }","duration":"130.197617ms","start":"2026-09-01T18:41:10.004277Z","end":"2026-09-01T18:41:10.134475Z","steps":["trace[842865859] 'agreement among raft nodes before linearized reading'  (duration: 130.037393ms)"],"step_count":1}
{"level":"info","ts":"2026-09-01T18:41:10.134537Z","caller":"traceutil/trace.go:171","msg":"trace[1837353859] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:6270; }","duration":"112.227991ms","start":"2026-09-01T18:41:10.022296Z","end":"2026-09-01T18:41:10.134524Z","steps":["trace[1837353859] 'agreement among raft nodes before linearized reading'  (duration: 112.020885ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-01T18:41:10.134791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.785668ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-fernet-setup\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-09-01T18:41:10.13479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.773663ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-credential-setup\" ","response":"range_response_count:1 size:6159"}
{"level":"info","ts":"2026-09-01T18:41:10.13483Z","caller":"traceutil/trace.go:171","msg":"trace[289687109] range","detail":"{range_begin:/registry/jobs/openstack/keystone-fernet-setup; range_end:; response_count:0; response_revision:6270; }","duration":"127.86196ms","start":"2026-09-01T18:41:10.00696Z","end":"2026-09-01T18:41:10.134822Z","steps":["trace[289687109] 'agreement among raft nodes before linearized reading'  (duration: 127.801629ms)"],"step_count":1}
{"level":"info","ts":"2026-09-01T18:41:10.134838Z","caller":"traceutil/trace.go:171","msg":"trace[1528166571] range","detail":"{range_begin:/registry/jobs/openstack/keystone-credential-setup; range_end:; response_count:1; response_revision:6270; }","duration":"118.846576ms","start":"2026-09-01T18:41:10.015981Z","end":"2026-09-01T18:41:10.134827Z","steps":["trace[1528166571] 'agreement among raft nodes before linearized reading'  (duration: 118.716481ms)"],"step_count":1}
{"level":"info","ts":"2026-09-01T18:41:10.134986Z","caller":"traceutil/trace.go:171","msg":"trace[744527238] transaction","detail":"{read_only:false; response_revision:6269; number_of_response:1; }","duration":"136.946076ms","start":"2026-09-01T18:41:09.998009Z","end":"2026-09-01T18:41:10.134955Z","steps":["trace[744527238] 'process raft request'  (duration: 11.577089ms)","trace[744527238] 'compare'  (duration: 124.046718ms)"],"step_count":2}
{"level":"info","ts":"2026-09-01T18:45:20.673014Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5817}
{"level":"info","ts":"2026-09-01T18:45:20.768956Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5817,"took":"93.174059ms","hash":2494767457,"current-db-size-bytes":56750080,"current-db-size":"57 MB","current-db-size-in-use-bytes":26603520,"current-db-size-in-use":"27 MB"}
{"level":"info","ts":"2026-09-01T18:45:20.769316Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2494767457,"revision":5817,"compact-revision":2959}
{"level":"info","ts":"2026-09-01T18:46:23.556382Z","caller":"traceutil/trace.go:171","msg":"trace[1932642905] transaction","detail":"{read_only:false; response_revision:8583; number_of_response:1; }","duration":"307.800195ms","start":"2026-09-01T18:46:23.24855Z","end":"2026-09-01T18:46:23.55635Z","steps":["trace[1932642905] 'process raft request'  (duration: 307.388653ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-01T18:46:23.556525Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T18:46:23.248525Z","time spent":"307.9308ms","remote":"127.0.0.1:55674","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":543,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" mod_revision:8363 > success:<request_put:<key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" value_size:466 >> failure:<request_range:<key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" > >"}
{"level":"info","ts":"2026-09-01T18:46:23.775644Z","caller":"traceutil/trace.go:171","msg":"trace[673757584] transaction","detail":"{read_only:false; response_revision:8584; number_of_response:1; }","duration":"214.950707ms","start":"2026-09-01T18:46:23.560672Z","end":"2026-09-01T18:46:23.775623Z","steps":["trace[673757584] 'process raft request'  (duration: 214.815393ms)"],"step_count":1}
{"level":"info","ts":"2026-09-01T18:46:23.776897Z","caller":"traceutil/trace.go:171","msg":"trace[1103846856] transaction","detail":"{read_only:false; response_revision:8585; number_of_response:1; }","duration":"216.067821ms","start":"2026-09-01T18:46:23.560754Z","end":"2026-09-01T18:46:23.776822Z","steps":["trace[1103846856] 'process raft request'  (duration: 215.677939ms)"],"step_count":1}
{"level":"info","ts":"2026-09-01T18:46:36.115559Z","caller":"traceutil/trace.go:171","msg":"trace[1222278185] transaction","detail":"{read_only:false; response_revision:8654; number_of_response:1; }","duration":"149.38427ms","start":"2026-09-01T18:46:35.966148Z","end":"2026-09-01T18:46:36.115532Z","steps":["trace[1222278185] 'process raft request'  (duration: 149.172823ms)"],"step_count":1}
{"level":"info","ts":"2026-09-01T18:47:05.464928Z","caller":"traceutil/trace.go:171","msg":"trace[1232599816] linearizableReadLoop","detail":"{readStateIndex:9180; appliedIndex:9179; }","duration":"298.183854ms","start":"2026-09-01T18:47:05.166716Z","end":"2026-09-01T18:47:05.4649Z","steps":["trace[1232599816] 'read index received'  (duration: 298.071ms)","trace[1232599816] 'applied index is now lower than readState.Index'  (duration: 111.424µs)"],"step_count":2}
{"level":"info","ts":"2026-09-01T18:47:05.465006Z","caller":"traceutil/trace.go:171","msg":"trace[1546378795] transaction","detail":"{read_only:false; response_revision:8862; number_of_response:1; }","duration":"425.98916ms","start":"2026-09-01T18:47:05.038982Z","end":"2026-09-01T18:47:05.464971Z","steps":["trace[1546378795] 'process raft request'  (duration: 425.753273ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-01T18:47:05.465143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.413401ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/exchanges/\" range_end:\"/registry/rabbitmq.com/exchanges0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-09-01T18:47:05.46517Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T18:47:05.038966Z","time spent":"426.112643ms","remote":"127.0.0.1:55674","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:8851 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-09-01T18:47:05.465152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.442994ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-09-01T18:47:05.465244Z","caller":"traceutil/trace.go:171","msg":"trace[415067618] range","detail":"{range_begin:/registry/rabbitmq.com/exchanges/; range_end:/registry/rabbitmq.com/exchanges0; response_count:0; response_revision:8862; }","duration":"298.577195ms","start":"2026-09-01T18:47:05.166649Z","end":"2026-09-01T18:47:05.465226Z","steps":["trace[415067618] 'agreement among raft nodes before linearized reading'  (duration: 298.41209ms)"],"step_count":1}
{"level":"info","ts":"2026-09-01T18:47:05.465261Z","caller":"traceutil/trace.go:171","msg":"trace[331318192] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:8862; }","duration":"277.617749ms","start":"2026-09-01T18:47:05.187627Z","end":"2026-09-01T18:47:05.465244Z","steps":["trace[331318192] 'agreement among raft nodes before linearized reading'  (duration: 277.439754ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-01T18:47:05.465464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.112186ms","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-01T18:47:05.465547Z","caller":"traceutil/trace.go:171","msg":"trace[1147089797] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8862; }","duration":"192.25052ms","start":"2026-09-01T18:47:05.273271Z","end":"2026-09-01T18:47:05.465521Z","steps":["trace[1147089797] 'agreement among raft nodes before linearized reading'  (duration: 191.969272ms)"],"step_count":1}
{"level":"info","ts":"2026-09-01T18:47:11.617526Z","caller":"traceutil/trace.go:171","msg":"trace[1621221383] linearizableReadLoop","detail":"{readStateIndex:9214; appliedIndex:9213; }","duration":"107.380406ms","start":"2026-09-01T18:47:11.510124Z","end":"2026-09-01T18:47:11.617504Z","steps":["trace[1621221383] 'read index received'  (duration: 107.230881ms)","trace[1621221383] 'applied index is now lower than readState.Index'  (duration: 148.604µs)"],"step_count":2}
{"level":"info","ts":"2026-09-01T18:47:11.61794Z","caller":"traceutil/trace.go:171","msg":"trace[1992342629] transaction","detail":"{read_only:false; response_revision:8895; number_of_response:1; }","duration":"122.703217ms","start":"2026-09-01T18:47:11.495222Z","end":"2026-09-01T18:47:11.617925Z","steps":["trace[1992342629] 'process raft request'  (duration: 122.137669ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-01T18:47:11.618343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.198691ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"}
{"level":"info","ts":"2026-09-01T18:47:11.618424Z","caller":"traceutil/trace.go:171","msg":"trace[678117058] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8895; }","duration":"108.330495ms","start":"2026-09-01T18:47:11.510073Z","end":"2026-09-01T18:47:11.618403Z","steps":["trace[678117058] 'agreement among raft nodes before linearized reading'  (duration: 108.102649ms)"],"step_count":1}
{"level":"info","ts":"2026-09-01T18:47:11.770406Z","caller":"traceutil/trace.go:171","msg":"trace[26089915] transaction","detail":"{read_only:false; response_revision:8896; number_of_response:1; }","duration":"149.366279ms","start":"2026-09-01T18:47:11.621004Z","end":"2026-09-01T18:47:11.77037Z","steps":["trace[26089915] 'process raft request'  (duration: 142.687263ms)"],"step_count":1}
{"level":"info","ts":"2026-09-01T18:47:11.77589Z","caller":"traceutil/trace.go:171","msg":"trace[1885063429] transaction","detail":"{read_only:false; response_revision:8897; number_of_response:1; }","duration":"152.542723ms","start":"2026-09-01T18:47:11.623312Z","end":"2026-09-01T18:47:11.775855Z","steps":["trace[1885063429] 'process raft request'  (duration: 152.404319ms)"],"step_count":1}
{"level":"info","ts":"2026-09-01T18:47:17.881077Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002435.wal"}
{"level":"info","ts":"2026-09-01T18:47:18.819053Z","caller":"traceutil/trace.go:171","msg":"trace[1736216356] transaction","detail":"{read_only:false; number_of_response:1; response_revision:8975; }","duration":"111.619521ms","start":"2026-09-01T18:47:18.707411Z","end":"2026-09-01T18:47:18.81903Z","steps":["trace[1736216356] 'process raft request'  (duration: 110.959361ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-01T18:47:19.452561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.277213ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9882199808960550710 > lease_revoke:<id:0924a05e3c86d5cb>","response":"size:28"}
{"level":"info","ts":"2026-09-01T18:48:24.506221Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"15a19459cc268924","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-09-01T18:48:24.513055Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-09-01T18:48:24.513181Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-09-01T18:48:39.536508Z","caller":"traceutil/trace.go:171","msg":"trace[534030484] transaction","detail":"{read_only:false; response_revision:9746; number_of_response:1; }","duration":"134.38529ms","start":"2026-09-01T18:48:39.402098Z","end":"2026-09-01T18:48:39.536483Z","steps":["trace[534030484] 'process raft request'  (duration: 134.212475ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-01T18:48:39.774732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.085528ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9882199808960552823 > lease_revoke:<id:0924a05e3c86de77>","response":"size:28"}
{"level":"info","ts":"2026-09-01T18:48:39.774844Z","caller":"traceutil/trace.go:171","msg":"trace[1736496915] linearizableReadLoop","detail":"{readStateIndex:10091; appliedIndex:10089; }","duration":"254.348755ms","start":"2026-09-01T18:48:39.520475Z","end":"2026-09-01T18:48:39.774824Z","steps":["trace[1736496915] 'read index received'  (duration: 15.854616ms)","trace[1736496915] 'applied index is now lower than readState.Index'  (duration: 238.492789ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-01T18:48:39.774999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.48529ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectrealms/\" range_end:\"/registry/ceph.rook.io/cephobjectrealms0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-01T18:48:39.775051Z","caller":"traceutil/trace.go:171","msg":"trace[1284282492] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectrealms/; range_end:/registry/ceph.rook.io/cephobjectrealms0; response_count:0; response_revision:9746; }","duration":"254.611593ms","start":"2026-09-01T18:48:39.520425Z","end":"2026-09-01T18:48:39.775037Z","steps":["trace[1284282492] 'agreement among raft nodes before linearized reading'  (duration: 254.49107ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-01T18:48:39.775061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.181464ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-01T18:48:39.775139Z","caller":"traceutil/trace.go:171","msg":"trace[1522403280] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:9746; }","duration":"134.331078ms","start":"2026-09-01T18:48:39.640787Z","end":"2026-09-01T18:48:39.775118Z","steps":["trace[1522403280] 'agreement among raft nodes before linearized reading'  (duration: 134.171713ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-01T18:48:39.775106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.030317ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-01T18:48:39.775214Z","caller":"traceutil/trace.go:171","msg":"trace[493129438] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:9746; }","duration":"105.184671ms","start":"2026-09-01T18:48:39.670004Z","end":"2026-09-01T18:48:39.775188Z","steps":["trace[493129438] 'agreement among raft nodes before linearized reading'  (duration: 104.997475ms)"],"step_count":1}
{"level":"info","ts":"2026-09-01T18:50:20.683029Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8021}
{"level":"info","ts":"2026-09-01T18:50:20.754333Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8021,"took":"69.160133ms","hash":2660082135,"current-db-size-bytes":56750080,"current-db-size":"57 MB","current-db-size-in-use-bytes":28635136,"current-db-size-in-use":"29 MB"}
{"level":"info","ts":"2026-09-01T18:50:20.754397Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2660082135,"revision":8021,"compact-revision":5817}
{"level":"warn","ts":"2026-09-01T18:52:22.010113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.08987ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9882199808960557679 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:11574 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-09-01T18:52:22.010253Z","caller":"traceutil/trace.go:171","msg":"trace[1940328878] transaction","detail":"{read_only:false; response_revision:11583; number_of_response:1; }","duration":"140.234524ms","start":"2026-09-01T18:52:21.869989Z","end":"2026-09-01T18:52:22.010223Z","steps":["trace[1940328878] 'process raft request'  (duration: 28.949278ms)","trace[1940328878] 'compare'  (duration: 110.964616ms)"],"step_count":2}
{"level":"info","ts":"2026-09-01T18:55:20.692414Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10448}
{"level":"info","ts":"2026-09-01T18:55:20.783907Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10448,"took":"89.029963ms","hash":1736748349,"current-db-size-bytes":56750080,"current-db-size":"57 MB","current-db-size-in-use-bytes":27656192,"current-db-size-in-use":"28 MB"}
{"level":"info","ts":"2026-09-01T18:55:20.78398Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1736748349,"revision":10448,"compact-revision":8021}
{"level":"info","ts":"2026-09-01T18:58:50.212889Z","caller":"traceutil/trace.go:171","msg":"trace[630014779] transaction","detail":"{read_only:false; response_revision:14171; number_of_response:1; }","duration":"303.810123ms","start":"2026-09-01T18:58:49.909048Z","end":"2026-09-01T18:58:50.212858Z","steps":["trace[630014779] 'process raft request'  (duration: 303.633198ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-01T18:58:50.213063Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T18:58:49.909026Z","time spent":"303.950858ms","remote":"127.0.0.1:55674","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:14161 > 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-01T18:58:50.213893Z","caller":"traceutil/trace.go:171","msg":"trace[842540487] linearizableReadLoop","detail":"{readStateIndex:14663; appliedIndex:14661; }","duration":"295.988764ms","start":"2026-09-01T18:58:49.917878Z","end":"2026-09-01T18:58:50.213867Z","steps":["trace[842540487] 'read index received'  (duration: 294.880011ms)","trace[842540487] 'applied index is now lower than readState.Index'  (duration: 1.107293ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-01T18:58:50.214135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.222941ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5683"}
{"level":"warn","ts":"2026-09-01T18:58:50.214135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.641873ms","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-01T18:58:50.214166Z","caller":"traceutil/trace.go:171","msg":"trace[2022867312] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:14172; }","duration":"296.309903ms","start":"2026-09-01T18:58:49.917847Z","end":"2026-09-01T18:58:50.214157Z","steps":["trace[2022867312] 'agreement among raft nodes before linearized reading'  (duration: 296.150369ms)"],"step_count":1}
{"level":"info","ts":"2026-09-01T18:58:50.214176Z","caller":"traceutil/trace.go:171","msg":"trace[255717569] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:14172; }","duration":"160.735227ms","start":"2026-09-01T18:58:50.053429Z","end":"2026-09-01T18:58:50.214164Z","steps":["trace[255717569] 'agreement among raft nodes before linearized reading'  (duration: 160.590302ms)"],"step_count":1}
{"level":"info","ts":"2026-09-01T18:58:50.213978Z","caller":"traceutil/trace.go:171","msg":"trace[1662809512] transaction","detail":"{read_only:false; response_revision:14172; number_of_response:1; }","duration":"302.889176ms","start":"2026-09-01T18:58:49.911046Z","end":"2026-09-01T18:58:50.213935Z","steps":["trace[1662809512] 'process raft request'  (duration: 302.632869ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-01T18:58:50.214452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.092047ms","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-01T18:58:50.21461Z","caller":"traceutil/trace.go:171","msg":"trace[619707399] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:14172; }","duration":"145.276532ms","start":"2026-09-01T18:58:50.069283Z","end":"2026-09-01T18:58:50.214559Z","steps":["trace[619707399] 'agreement among raft nodes before linearized reading'  (duration: 144.85263ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-01T18:58:50.214708Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T18:58:49.911019Z","time spent":"303.528735ms","remote":"127.0.0.1:55674","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:14162 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-09-01T18:58:50.416103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.660839ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectrealms/\" range_end:\"/registry/ceph.rook.io/cephobjectrealms0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-01T18:58:50.416201Z","caller":"traceutil/trace.go:171","msg":"trace[2118609682] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectrealms/; range_end:/registry/ceph.rook.io/cephobjectrealms0; response_count:0; response_revision:14174; }","duration":"121.836755ms","start":"2026-09-01T18:58:50.29434Z","end":"2026-09-01T18:58:50.416177Z","steps":["trace[2118609682] 'count revisions from in-memory index tree'  (duration: 121.558206ms)"],"step_count":1}
{"level":"info","ts":"2026-09-01T18:59:02.441126Z","caller":"traceutil/trace.go:171","msg":"trace[1402755478] transaction","detail":"{read_only:false; response_revision:14252; number_of_response:1; }","duration":"148.524828ms","start":"2026-09-01T18:59:02.292565Z","end":"2026-09-01T18:59:02.44109Z","steps":["trace[1402755478] 'process raft request'  (duration: 148.064004ms)"],"step_count":1}
{"level":"info","ts":"2026-09-01T18:59:02.441286Z","caller":"traceutil/trace.go:171","msg":"trace[1004567916] transaction","detail":"{read_only:false; response_revision:14253; number_of_response:1; }","duration":"148.60535ms","start":"2026-09-01T18:59:02.292653Z","end":"2026-09-01T18:59:02.441258Z","steps":["trace[1004567916] 'process raft request'  (duration: 148.395814ms)"],"step_count":1}
{"level":"info","ts":"2026-09-01T18:59:09.371879Z","caller":"traceutil/trace.go:171","msg":"trace[229038222] linearizableReadLoop","detail":"{readStateIndex:14784; appliedIndex:14783; }","duration":"247.522132ms","start":"2026-09-01T18:59:09.124324Z","end":"2026-09-01T18:59:09.371846Z","steps":["trace[229038222] 'read index received'  (duration: 247.297576ms)","trace[229038222] 'applied index is now lower than readState.Index'  (duration: 223.156µs)"],"step_count":2}
{"level":"info","ts":"2026-09-01T18:59:09.372007Z","caller":"traceutil/trace.go:171","msg":"trace[2102712001] transaction","detail":"{read_only:false; response_revision:14289; number_of_response:1; }","duration":"267.862678ms","start":"2026-09-01T18:59:09.104107Z","end":"2026-09-01T18:59:09.37197Z","steps":["trace[2102712001] 'process raft request'  (duration: 267.548699ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-01T18:59:09.372326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.987655ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:558"}
{"level":"info","ts":"2026-09-01T18:59:09.372449Z","caller":"traceutil/trace.go:171","msg":"trace[29840537] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:14289; }","duration":"248.15891ms","start":"2026-09-01T18:59:09.124266Z","end":"2026-09-01T18:59:09.372425Z","steps":["trace[29840537] 'agreement among raft nodes before linearized reading'  (duration: 247.754618ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-01T18:59:10.041139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"523.445748ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9882199808960565477 > lease_revoke:<id:0924a05e3c870fdf>","response":"size:28"}
{"level":"info","ts":"2026-09-01T18:59:10.041456Z","caller":"traceutil/trace.go:171","msg":"trace[1544037368] linearizableReadLoop","detail":"{readStateIndex:14786; appliedIndex:14784; }","duration":"669.458631ms","start":"2026-09-01T18:59:09.371979Z","end":"2026-09-01T18:59:10.041437Z","steps":["trace[1544037368] 'read index received'  (duration: 145.826478ms)","trace[1544037368] 'applied index is now lower than readState.Index'  (duration: 523.631183ms)"],"step_count":2}
{"level":"info","ts":"2026-09-01T18:59:10.041555Z","caller":"traceutil/trace.go:171","msg":"trace[1351301953] transaction","detail":"{read_only:false; response_revision:14290; number_of_response:1; }","duration":"741.67832ms","start":"2026-09-01T18:59:09.299867Z","end":"2026-09-01T18:59:10.041546Z","steps":["trace[1351301953] 'process raft request'  (duration: 741.363491ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-01T18:59:10.041744Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T18:59:09.299839Z","time spent":"741.834855ms","remote":"127.0.0.1:55674","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:14277 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"warn","ts":"2026-09-01T18:59:10.041892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"817.242156ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-01T18:59:10.042006Z","caller":"traceutil/trace.go:171","msg":"trace[1345909844] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:14291; }","duration":"817.442862ms","start":"2026-09-01T18:59:09.224536Z","end":"2026-09-01T18:59:10.041979Z","steps":["trace[1345909844] 'agreement among raft nodes before linearized reading'  (duration: 817.136643ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-01T18:59:10.042052Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T18:59:09.224511Z","time spent":"817.528585ms","remote":"127.0.0.1:57268","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true "}
{"level":"warn","ts":"2026-09-01T18:59:10.042018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"431.344555ms","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-01T18:59:10.041896Z","caller":"traceutil/trace.go:171","msg":"trace[1452556301] transaction","detail":"{read_only:false; response_revision:14291; number_of_response:1; }","duration":"662.059774ms","start":"2026-09-01T18:59:09.379785Z","end":"2026-09-01T18:59:10.041845Z","steps":["trace[1452556301] 'process raft request'  (duration: 661.601041ms)"],"step_count":1}
{"level":"info","ts":"2026-09-01T18:59:10.042127Z","caller":"traceutil/trace.go:171","msg":"trace[1661068820] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:14291; }","duration":"431.495729ms","start":"2026-09-01T18:59:09.610608Z","end":"2026-09-01T18:59:10.042104Z","steps":["trace[1661068820] 'agreement among raft nodes before linearized reading'  (duration: 431.199941ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-01T18:59:10.042168Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T18:59:09.610597Z","time spent":"431.560582ms","remote":"127.0.0.1:55674","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-09-01T18:59:10.042179Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T18:59:09.37976Z","time spent":"662.381534ms","remote":"127.0.0.1:55674","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":543,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" mod_revision:14191 > success:<request_put:<key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" value_size:466 >> failure:<request_range:<key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" > >"}
{"level":"warn","ts":"2026-09-01T18:59:10.04221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"431.47125ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"}
{"level":"info","ts":"2026-09-01T18:59:10.042359Z","caller":"traceutil/trace.go:171","msg":"trace[1736284853] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:14291; }","duration":"431.979244ms","start":"2026-09-01T18:59:09.610335Z","end":"2026-09-01T18:59:10.042314Z","steps":["trace[1736284853] 'agreement among raft nodes before linearized reading'  (duration: 431.550151ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-01T18:59:10.042419Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T18:59:09.610275Z","time spent":"432.134249ms","remote":"127.0.0.1:55674","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-09-01T19:00:18.599486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.397371ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9882199808960568036 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:15183 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-09-01T19:00:18.599817Z","caller":"traceutil/trace.go:171","msg":"trace[1515215392] transaction","detail":"{read_only:false; response_revision:15194; number_of_response:1; }","duration":"177.077335ms","start":"2026-09-01T19:00:18.422706Z","end":"2026-09-01T19:00:18.599783Z","steps":["trace[1515215392] 'process raft request'  (duration: 23.295843ms)","trace[1515215392] 'compare'  (duration: 153.198085ms)"],"step_count":2}
{"level":"info","ts":"2026-09-01T19:00:20.699645Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12768}
{"level":"info","ts":"2026-09-01T19:00:20.791455Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12768,"took":"88.917248ms","hash":1466985960,"current-db-size-bytes":56750080,"current-db-size":"57 MB","current-db-size-in-use-bytes":30441472,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-09-01T19:00:20.791508Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1466985960,"revision":12768,"compact-revision":10448}
{"level":"info","ts":"2026-09-01T19:00:51.910035Z","caller":"traceutil/trace.go:171","msg":"trace[1598512666] transaction","detail":"{read_only:false; response_revision:15372; number_of_response:1; }","duration":"107.106493ms","start":"2026-09-01T19:00:51.802897Z","end":"2026-09-01T19:00:51.910004Z","steps":["trace[1598512666] 'process raft request'  (duration: 106.508565ms)"],"step_count":1}
{"level":"info","ts":"2026-09-01T19:00:52.662525Z","caller":"traceutil/trace.go:171","msg":"trace[984302005] transaction","detail":"{read_only:false; response_revision:15373; number_of_response:1; }","duration":"243.969397ms","start":"2026-09-01T19:00:52.418534Z","end":"2026-09-01T19:00:52.662504Z","steps":["trace[984302005] 'process raft request'  (duration: 243.508554ms)"],"step_count":1}
{"level":"info","ts":"2026-09-01T19:05:20.717631Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15206}
{"level":"info","ts":"2026-09-01T19:05:20.815535Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15206,"took":"95.025943ms","hash":462140907,"current-db-size-bytes":56750080,"current-db-size":"57 MB","current-db-size-in-use-bytes":32337920,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-09-01T19:05:20.815587Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":462140907,"revision":15206,"compact-revision":12768}
{"level":"info","ts":"2026-09-01T19:06:22.707029Z","caller":"traceutil/trace.go:171","msg":"trace[156654104] transaction","detail":"{read_only:false; response_revision:17896; number_of_response:1; }","duration":"174.871361ms","start":"2026-09-01T19:06:22.532133Z","end":"2026-09-01T19:06:22.707004Z","steps":["trace[156654104] 'process raft request'  (duration: 174.709548ms)"],"step_count":1}
{"level":"info","ts":"2026-09-01T19:06:22.709361Z","caller":"traceutil/trace.go:171","msg":"trace[331472570] transaction","detail":"{read_only:false; response_revision:17897; number_of_response:1; }","duration":"118.878954ms","start":"2026-09-01T19:06:22.590451Z","end":"2026-09-01T19:06:22.70933Z","steps":["trace[331472570] 'process raft request'  (duration: 118.294453ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-01T19:06:29.154909Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9882199808960579156,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-09-01T19:06:29.207132Z","caller":"traceutil/trace.go:171","msg":"trace[753456238] transaction","detail":"{read_only:false; response_revision:17931; number_of_response:1; }","duration":"579.239099ms","start":"2026-09-01T19:06:28.62787Z","end":"2026-09-01T19:06:29.207109Z","steps":["trace[753456238] 'process raft request'  (duration: 579.075726ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-01T19:06:29.207383Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T19:06:28.627843Z","time spent":"579.420703ms","remote":"127.0.0.1:55582","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":20878,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/pods/openstack/libvirt-libvirt-default-fv4k6\" mod_revision:17850 > success:<request_put:<key:\"/registry/pods/openstack/libvirt-libvirt-default-fv4k6\" value_size:20814 >> failure:<request_range:<key:\"/registry/pods/openstack/libvirt-libvirt-default-fv4k6\" > >"}
{"level":"info","ts":"2026-09-01T19:06:29.230965Z","caller":"traceutil/trace.go:171","msg":"trace[242496117] transaction","detail":"{read_only:false; response_revision:17932; number_of_response:1; }","duration":"497.518653ms","start":"2026-09-01T19:06:28.733421Z","end":"2026-09-01T19:06:29.230939Z","steps":["trace[242496117] 'process raft request'  (duration: 497.312179ms)"],"step_count":1}
{"level":"info","ts":"2026-09-01T19:06:29.231118Z","caller":"traceutil/trace.go:171","msg":"trace[990592436] linearizableReadLoop","detail":"{readStateIndex:18548; appliedIndex:18545; }","duration":"576.672639ms","start":"2026-09-01T19:06:28.654427Z","end":"2026-09-01T19:06:29.2311Z","steps":["trace[990592436] 'read index received'  (duration: 552.603772ms)","trace[990592436] 'applied index is now lower than readState.Index'  (duration: 24.067557ms)"],"step_count":2}
{"level":"info","ts":"2026-09-01T19:06:29.231208Z","caller":"traceutil/trace.go:171","msg":"trace[2069377037] transaction","detail":"{read_only:false; response_revision:17933; number_of_response:1; }","duration":"124.477978ms","start":"2026-09-01T19:06:29.106709Z","end":"2026-09-01T19:06:29.231187Z","steps":["trace[2069377037] 'process raft request'  (duration: 124.188942ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-01T19:06:29.231272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"576.836433ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-01T19:06:29.231341Z","caller":"traceutil/trace.go:171","msg":"trace[183771006] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:17933; }","duration":"576.964615ms","start":"2026-09-01T19:06:28.654361Z","end":"2026-09-01T19:06:29.231326Z","steps":["trace[183771006] 'agreement among raft nodes before linearized reading'  (duration: 576.827143ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-01T19:06:29.231377Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T19:06:28.65434Z","time spent":"577.027416ms","remote":"127.0.0.1:35082","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true "}
{"level":"warn","ts":"2026-09-01T19:06:29.23139Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T19:06:28.733397Z","time spent":"497.729617ms","remote":"127.0.0.1:55674","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:17917 > 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-01T19:06:29.319641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"618.082993ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-09-01T19:06:29.319773Z","caller":"traceutil/trace.go:171","msg":"trace[1029877232] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:17933; }","duration":"618.290767ms","start":"2026-09-01T19:06:28.701453Z","end":"2026-09-01T19:06:29.319744Z","steps":["trace[1029877232] 'agreement among raft nodes before linearized reading'  (duration: 618.031972ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-01T19:06:29.319797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.943779ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"}
{"level":"warn","ts":"2026-09-01T19:06:29.319833Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T19:06:28.701442Z","time spent":"618.373619ms","remote":"127.0.0.1:35242","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":1,"response size":31,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "}
{"level":"warn","ts":"2026-09-01T19:06:29.319859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"576.731401ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"}
{"level":"info","ts":"2026-09-01T19:06:29.319893Z","caller":"traceutil/trace.go:171","msg":"trace[1289664722] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:17933; }","duration":"346.085551ms","start":"2026-09-01T19:06:28.973784Z","end":"2026-09-01T19:06:29.319869Z","steps":["trace[1289664722] 'agreement among raft nodes before linearized reading'  (duration: 345.753084ms)"],"step_count":1}
{"level":"info","ts":"2026-09-01T19:06:29.319938Z","caller":"traceutil/trace.go:171","msg":"trace[20418939] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:17933; }","duration":"576.848583ms","start":"2026-09-01T19:06:28.743071Z","end":"2026-09-01T19:06:29.31992Z","steps":["trace[20418939] 'agreement among raft nodes before linearized reading'  (duration: 576.598278ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-01T19:06:29.319989Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T19:06:28.743061Z","time spent":"576.919024ms","remote":"127.0.0.1:55674","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":464,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-09-01T19:06:29.319983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"584.657624ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"}
{"level":"warn","ts":"2026-09-01T19:06:29.320061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.859259ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-cinder-server-0\" ","response":"range_response_count:1 size:1858"}
{"level":"info","ts":"2026-09-01T19:06:29.320098Z","caller":"traceutil/trace.go:171","msg":"trace[1098609188] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-cinder-server-0; range_end:; response_count:1; response_revision:17933; }","duration":"324.932721ms","start":"2026-09-01T19:06:28.995154Z","end":"2026-09-01T19:06:29.320087Z","steps":["trace[1098609188] 'agreement among raft nodes before linearized reading'  (duration: 324.834809ms)"],"step_count":1}
{"level":"info","ts":"2026-09-01T19:06:29.320097Z","caller":"traceutil/trace.go:171","msg":"trace[707462033] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:17933; }","duration":"584.827687ms","start":"2026-09-01T19:06:28.735241Z","end":"2026-09-01T19:06:29.320068Z","steps":["trace[707462033] 'agreement among raft nodes before linearized reading'  (duration: 584.493061ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-01T19:06:29.320134Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T19:06:28.995137Z","time spent":"324.987092ms","remote":"127.0.0.1:55552","response type":"/etcdserverpb.KV/Range","request count":0,"request size":81,"response count":1,"response size":1881,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-cinder-server-0\" "}
{"level":"warn","ts":"2026-09-01T19:06:29.320154Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T19:06:28.73522Z","time spent":"584.92469ms","remote":"127.0.0.1:55674","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":532,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-09-01T19:06:29.319945Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T19:06:28.973769Z","time spent":"346.165973ms","remote":"127.0.0.1:55674","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-01T19:06:29.320721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"554.959127ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:558"}
{"level":"warn","ts":"2026-09-01T19:06:29.320724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"439.267011ms","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-01T19:06:29.320834Z","caller":"traceutil/trace.go:171","msg":"trace[43748491] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:17933; }","duration":"555.084569ms","start":"2026-09-01T19:06:28.765727Z","end":"2026-09-01T19:06:29.320811Z","steps":["trace[43748491] 'agreement among raft nodes before linearized reading'  (duration: 553.937027ms)"],"step_count":1}
{"level":"info","ts":"2026-09-01T19:06:29.320912Z","caller":"traceutil/trace.go:171","msg":"trace[344988202] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:17933; }","duration":"439.498566ms","start":"2026-09-01T19:06:28.881389Z","end":"2026-09-01T19:06:29.320888Z","steps":["trace[344988202] 'agreement among raft nodes before linearized reading'  (duration: 438.922575ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-01T19:06:29.321049Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T19:06:28.881369Z","time spent":"439.664438ms","remote":"127.0.0.1:55674","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-01T19:06:29.320931Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T19:06:28.765692Z","time spent":"555.227842ms","remote":"127.0.0.1:55674","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":581,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"info","ts":"2026-09-01T19:06:39.550509Z","caller":"traceutil/trace.go:171","msg":"trace[557639765] linearizableReadLoop","detail":"{readStateIndex:18736; appliedIndex:18734; }","duration":"124.717432ms","start":"2026-09-01T19:06:39.425756Z","end":"2026-09-01T19:06:39.550473Z","steps":["trace[557639765] 'read index received'  (duration: 4.479797ms)","trace[557639765] 'applied index is now lower than readState.Index'  (duration: 120.236185ms)"],"step_count":2}
{"level":"info","ts":"2026-09-01T19:06:39.550814Z","caller":"traceutil/trace.go:171","msg":"trace[1584996923] transaction","detail":"{read_only:false; response_revision:18113; number_of_response:1; }","duration":"124.551299ms","start":"2026-09-01T19:06:39.426237Z","end":"2026-09-01T19:06:39.550788Z","steps":["trace[1584996923] 'process raft request'  (duration: 124.160182ms)"],"step_count":1}
{"level":"info","ts":"2026-09-01T19:06:39.550815Z","caller":"traceutil/trace.go:171","msg":"trace[739126452] transaction","detail":"{read_only:false; response_revision:18112; number_of_response:1; }","duration":"125.392575ms","start":"2026-09-01T19:06:39.425389Z","end":"2026-09-01T19:06:39.550782Z","steps":["trace[739126452] 'process raft request'  (duration: 38.164931ms)","trace[739126452] 'compare'  (duration: 86.665623ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-01T19:06:39.550824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.038428ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-09-01T19:06:39.550913Z","caller":"traceutil/trace.go:171","msg":"trace[1167640375] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:18113; }","duration":"125.14303ms","start":"2026-09-01T19:06:39.42575Z","end":"2026-09-01T19:06:39.550893Z","steps":["trace[1167640375] 'agreement among raft nodes before linearized reading'  (duration: 124.886405ms)"],"step_count":1}
{"level":"info","ts":"2026-09-01T19:09:08.770183Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"15a19459cc268924","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-09-01T19:09:08.778546Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002}
{"level":"info","ts":"2026-09-01T19:09:08.778646Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002}
{"level":"info","ts":"2026-09-01T19:10:20.727306Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17469}
{"level":"info","ts":"2026-09-01T19:10:20.840256Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17469,"took":"107.832395ms","hash":3572187317,"current-db-size-bytes":56750080,"current-db-size":"57 MB","current-db-size-in-use-bytes":34856960,"current-db-size-in-use":"35 MB"}
{"level":"info","ts":"2026-09-01T19:10:20.840338Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3572187317,"revision":17469,"compact-revision":15206}
{"level":"info","ts":"2026-09-01T19:11:43.106762Z","caller":"traceutil/trace.go:171","msg":"trace[81105508] transaction","detail":"{read_only:false; response_revision:20445; number_of_response:1; }","duration":"118.022477ms","start":"2026-09-01T19:11:42.988708Z","end":"2026-09-01T19:11:43.10673Z","steps":["trace[81105508] 'process raft request'  (duration: 117.858663ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-01T19:11:43.283827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.048374ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9882199808960586371 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:20393 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:599 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >>","response":"size:18"}
{"level":"info","ts":"2026-09-01T19:11:43.283964Z","caller":"traceutil/trace.go:171","msg":"trace[1581016865] linearizableReadLoop","detail":"{readStateIndex:21144; appliedIndex:21143; }","duration":"231.879712ms","start":"2026-09-01T19:11:43.052062Z","end":"2026-09-01T19:11:43.283941Z","steps":["trace[1581016865] 'read index received'  (duration: 54.81502ms)","trace[1581016865] 'applied index is now lower than readState.Index'  (duration: 177.062572ms)"],"step_count":2}
{"level":"info","ts":"2026-09-01T19:11:43.284021Z","caller":"traceutil/trace.go:171","msg":"trace[847227423] transaction","detail":"{read_only:false; response_revision:20446; number_of_response:1; }","duration":"278.019648ms","start":"2026-09-01T19:11:43.005948Z","end":"2026-09-01T19:11:43.283967Z","steps":["trace[847227423] 'process raft request'  (duration: 121.668825ms)","trace[847227423] 'compare'  (duration: 155.90273ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-01T19:11:43.284405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.346724ms","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-01T19:11:43.28453Z","caller":"traceutil/trace.go:171","msg":"trace[1197588524] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:20446; }","duration":"232.500828ms","start":"2026-09-01T19:11:43.052012Z","end":"2026-09-01T19:11:43.284512Z","steps":["trace[1197588524] 'agreement among raft nodes before linearized reading'  (duration: 232.109308ms)"],"step_count":1}
{"level":"info","ts":"2026-09-01T19:11:43.362474Z","caller":"traceutil/trace.go:171","msg":"trace[1216158498] transaction","detail":"{read_only:false; response_revision:20447; number_of_response:1; }","duration":"156.211638ms","start":"2026-09-01T19:11:43.206219Z","end":"2026-09-01T19:11:43.36243Z","steps":["trace[1216158498] 'process raft request'  (duration: 155.995032ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-01T19:11:43.362609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.579713ms","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-01T19:11:43.362698Z","caller":"traceutil/trace.go:171","msg":"trace[512755263] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:20447; }","duration":"158.775638ms","start":"2026-09-01T19:11:43.203904Z","end":"2026-09-01T19:11:43.362679Z","steps":["trace[512755263] 'agreement among raft nodes before linearized reading'  (duration: 158.492581ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-01T19:11:43.362913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.336651ms","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-01T19:11:43.363069Z","caller":"traceutil/trace.go:171","msg":"trace[281375244] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:20447; }","duration":"303.503806ms","start":"2026-09-01T19:11:43.059477Z","end":"2026-09-01T19:11:43.362981Z","steps":["trace[281375244] 'agreement among raft nodes before linearized reading'  (duration: 302.991312ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-01T19:11:43.363127Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T19:11:43.059423Z","time spent":"303.69168ms","remote":"127.0.0.1:55674","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":517,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"info","ts":"2026-09-01T19:11:43.40744Z","caller":"traceutil/trace.go:171","msg":"trace[1723561370] transaction","detail":"{read_only:false; response_revision:20448; number_of_response:1; }","duration":"117.951366ms","start":"2026-09-01T19:11:43.28947Z","end":"2026-09-01T19:11:43.407421Z","steps":["trace[1723561370] 'process raft request'  (duration: 117.829593ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-01T19:11:53.606624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.692873ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"}
{"level":"info","ts":"2026-09-01T19:11:53.606726Z","caller":"traceutil/trace.go:171","msg":"trace[159079721] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:20497; }","duration":"142.832107ms","start":"2026-09-01T19:11:53.46387Z","end":"2026-09-01T19:11:53.606702Z","steps":["trace[159079721] 'range keys from in-memory index tree'  (duration: 142.502408ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-01T19:11:53.606978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.955922ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"}
{"level":"warn","ts":"2026-09-01T19:11:53.607209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.83769ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:558"}
{"level":"warn","ts":"2026-09-01T19:11:53.60707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.797338ms","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-01T19:11:53.60734Z","caller":"traceutil/trace.go:171","msg":"trace[1955592859] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:20497; }","duration":"101.982764ms","start":"2026-09-01T19:11:53.505326Z","end":"2026-09-01T19:11:53.607309Z","steps":["trace[1955592859] 'range keys from in-memory index tree'  (duration: 101.618243ms)"],"step_count":1}
{"level":"info","ts":"2026-09-01T19:11:53.607266Z","caller":"traceutil/trace.go:171","msg":"trace[1684746873] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:20497; }","duration":"152.300963ms","start":"2026-09-01T19:11:53.454941Z","end":"2026-09-01T19:11:53.607242Z","steps":["trace[1684746873] 'range keys from in-memory index tree'  (duration: 151.746287ms)"],"step_count":1}
{"level":"info","ts":"2026-09-01T19:11:53.607436Z","caller":"traceutil/trace.go:171","msg":"trace[185682831] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:20497; }","duration":"149.169508ms","start":"2026-09-01T19:11:53.458212Z","end":"2026-09-01T19:11:53.607381Z","steps":["trace[185682831] 'range keys from in-memory index tree'  (duration: 148.578311ms)"],"step_count":1}
{"level":"info","ts":"2026-09-01T19:11:59.411514Z","caller":"traceutil/trace.go:171","msg":"trace[654904652] transaction","detail":"{read_only:false; response_revision:20528; number_of_response:1; }","duration":"197.511303ms","start":"2026-09-01T19:11:59.213981Z","end":"2026-09-01T19:11:59.411492Z","steps":["trace[654904652] 'process raft request'  (duration: 197.302288ms)"],"step_count":1}
{"level":"info","ts":"2026-09-01T19:11:59.551807Z","caller":"traceutil/trace.go:171","msg":"trace[1058819425] transaction","detail":"{read_only:false; response_revision:20529; number_of_response:1; }","duration":"127.441021ms","start":"2026-09-01T19:11:59.424317Z","end":"2026-09-01T19:11:59.551758Z","steps":["trace[1058819425] 'process raft request'  (duration: 111.84359ms)","trace[1058819425] 'compare'  (duration: 15.392785ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-01T19:11:59.884737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.755058ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9882199808960586625 > lease_revoke:<id:0924a05e3c87629a>","response":"size:29"}
{"level":"info","ts":"2026-09-01T19:11:59.885052Z","caller":"traceutil/trace.go:171","msg":"trace[1797630544] transaction","detail":"{read_only:false; response_revision:20530; number_of_response:1; }","duration":"239.23334ms","start":"2026-09-01T19:11:59.645797Z","end":"2026-09-01T19:11:59.88503Z","steps":["trace[1797630544] 'process raft request'  (duration: 239.053175ms)"],"step_count":1}
{"level":"info","ts":"2026-09-01T19:11:59.885587Z","caller":"traceutil/trace.go:171","msg":"trace[1455111412] transaction","detail":"{read_only:false; response_revision:20531; number_of_response:1; }","duration":"238.46716ms","start":"2026-09-01T19:11:59.647067Z","end":"2026-09-01T19:11:59.885534Z","steps":["trace[1455111412] 'process raft request'  (duration: 237.914335ms)"],"step_count":1}
{"level":"info","ts":"2026-09-01T19:11:59.885656Z","caller":"traceutil/trace.go:171","msg":"trace[611825153] linearizableReadLoop","detail":"{readStateIndex:21232; appliedIndex:21230; }","duration":"238.602824ms","start":"2026-09-01T19:11:59.646989Z","end":"2026-09-01T19:11:59.885592Z","steps":["trace[611825153] 'read index received'  (duration: 48.999853ms)","trace[611825153] 'applied index is now lower than readState.Index'  (duration: 189.601331ms)"],"step_count":2}
{"level":"info","ts":"2026-09-01T19:11:59.885761Z","caller":"traceutil/trace.go:171","msg":"trace[507072816] transaction","detail":"{read_only:false; response_revision:20532; number_of_response:1; }","duration":"238.075659ms","start":"2026-09-01T19:11:59.647616Z","end":"2026-09-01T19:11:59.885692Z","steps":["trace[507072816] 'process raft request'  (duration: 237.807202ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-01T19:11:59.885911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.890611ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:558"}
{"level":"info","ts":"2026-09-01T19:11:59.885953Z","caller":"traceutil/trace.go:171","msg":"trace[1760731099] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:20532; }","duration":"238.970343ms","start":"2026-09-01T19:11:59.646965Z","end":"2026-09-01T19:11:59.885936Z","steps":["trace[1760731099] 'agreement among raft nodes before linearized reading'  (duration: 238.773208ms)"],"step_count":1}
{"level":"info","ts":"2026-09-01T19:12:00.194787Z","caller":"traceutil/trace.go:171","msg":"trace[1853955789] transaction","detail":"{read_only:false; response_revision:20533; number_of_response:1; }","duration":"301.249264ms","start":"2026-09-01T19:11:59.893502Z","end":"2026-09-01T19:12:00.194752Z","steps":["trace[1853955789] 'process raft request'  (duration: 301.07848ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-01T19:12:00.194956Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T19:11:59.893479Z","time spent":"301.385989ms","remote":"127.0.0.1:55674","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:20523 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:464 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"info","ts":"2026-09-01T19:15:20.750218Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19896}
{"level":"info","ts":"2026-09-01T19:15:20.96177Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19896,"took":"206.575644ms","hash":2236785764,"current-db-size-bytes":56750080,"current-db-size":"57 MB","current-db-size-in-use-bytes":30814208,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-09-01T19:15:20.961903Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2236785764,"revision":19896,"compact-revision":17469}
{"level":"info","ts":"2026-09-01T19:15:51.705751Z","caller":"traceutil/trace.go:171","msg":"trace[19815709] transaction","detail":"{read_only:false; response_revision:22954; number_of_response:1; }","duration":"288.779979ms","start":"2026-09-01T19:15:51.416944Z","end":"2026-09-01T19:15:51.705724Z","steps":["trace[19815709] 'process raft request'  (duration: 283.114207ms)"],"step_count":1}
{"level":"info","ts":"2026-09-01T19:15:51.724573Z","caller":"traceutil/trace.go:171","msg":"trace[238381285] linearizableReadLoop","detail":"{readStateIndex:23729; appliedIndex:23727; }","duration":"163.288811ms","start":"2026-09-01T19:15:51.561261Z","end":"2026-09-01T19:15:51.72455Z","steps":["trace[238381285] 'read index received'  (duration: 138.905882ms)","trace[238381285] 'applied index is now lower than readState.Index'  (duration: 24.381819ms)"],"step_count":2}
{"level":"info","ts":"2026-09-01T19:15:51.724953Z","caller":"traceutil/trace.go:171","msg":"trace[1499262424] transaction","detail":"{read_only:false; response_revision:22955; number_of_response:1; }","duration":"173.300571ms","start":"2026-09-01T19:15:51.551639Z","end":"2026-09-01T19:15:51.72494Z","steps":["trace[1499262424] 'process raft request'  (duration: 172.765418ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-01T19:15:51.725297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.015011ms","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:9"}
{"level":"info","ts":"2026-09-01T19:15:51.725338Z","caller":"traceutil/trace.go:171","msg":"trace[1642160024] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:22955; }","duration":"164.078202ms","start":"2026-09-01T19:15:51.561249Z","end":"2026-09-01T19:15:51.725327Z","steps":["trace[1642160024] 'agreement among raft nodes before linearized reading'  (duration: 163.885348ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-01T19:15:51.747206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.351873ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-01T19:15:51.747305Z","caller":"traceutil/trace.go:171","msg":"trace[1972982166] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:22956; }","duration":"105.526627ms","start":"2026-09-01T19:15:51.641755Z","end":"2026-09-01T19:15:51.747282Z","steps":["trace[1972982166] 'agreement among raft nodes before linearized reading'  (duration: 104.80529ms)"],"step_count":1}
{"level":"info","ts":"2026-09-01T19:17:10.800276Z","caller":"traceutil/trace.go:171","msg":"trace[1654425597] linearizableReadLoop","detail":"{readStateIndex:24626; appliedIndex:24625; }","duration":"140.421249ms","start":"2026-09-01T19:17:10.659795Z","end":"2026-09-01T19:17:10.800216Z","steps":["trace[1654425597] 'read index received'  (duration: 140.080711ms)","trace[1654425597] 'applied index is now lower than readState.Index'  (duration: 338.978µs)"],"step_count":2}
{"level":"info","ts":"2026-09-01T19:17:10.80034Z","caller":"traceutil/trace.go:171","msg":"trace[2005747773] transaction","detail":"{read_only:false; response_revision:23830; number_of_response:1; }","duration":"142.898121ms","start":"2026-09-01T19:17:10.657398Z","end":"2026-09-01T19:17:10.800296Z","steps":["trace[2005747773] 'process raft request'  (duration: 142.605734ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-01T19:17:10.80054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.698787ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/clusters/\" range_end:\"/registry/cluster.x-k8s.io/clusters0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-01T19:17:10.800647Z","caller":"traceutil/trace.go:171","msg":"trace[1909921798] range","detail":"{range_begin:/registry/cluster.x-k8s.io/clusters/; range_end:/registry/cluster.x-k8s.io/clusters0; response_count:0; response_revision:23830; }","duration":"140.888781ms","start":"2026-09-01T19:17:10.659733Z","end":"2026-09-01T19:17:10.800622Z","steps":["trace[1909921798] 'agreement among raft nodes before linearized reading'  (duration: 140.674056ms)"],"step_count":1}
{"level":"info","ts":"2026-09-01T19:20:20.757797Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":22165}
{"level":"info","ts":"2026-09-01T19:20:20.866597Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":22165,"took":"104.921629ms","hash":2391058324,"current-db-size-bytes":56750080,"current-db-size":"57 MB","current-db-size-in-use-bytes":41852928,"current-db-size-in-use":"42 MB"}
{"level":"info","ts":"2026-09-01T19:20:20.866663Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2391058324,"revision":22165,"compact-revision":19896}
{"level":"info","ts":"2026-09-01T19:24:04.360573Z","caller":"traceutil/trace.go:171","msg":"trace[419796227] linearizableReadLoop","detail":"{readStateIndex:27799; appliedIndex:27798; }","duration":"101.63375ms","start":"2026-09-01T19:24:04.258905Z","end":"2026-09-01T19:24:04.360539Z","steps":["trace[419796227] 'read index received'  (duration: 19.355386ms)","trace[419796227] 'applied index is now lower than readState.Index'  (duration: 82.276684ms)"],"step_count":2}
{"level":"info","ts":"2026-09-01T19:24:04.360661Z","caller":"traceutil/trace.go:171","msg":"trace[1040882026] transaction","detail":"{read_only:false; response_revision:26914; number_of_response:1; }","duration":"103.498269ms","start":"2026-09-01T19:24:04.257121Z","end":"2026-09-01T19:24:04.360619Z","steps":["trace[1040882026] 'process raft request'  (duration: 21.201085ms)","trace[1040882026] 'compare'  (duration: 81.797671ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-01T19:24:04.361285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.352859ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-create-internal-tenant\" ","response":"range_response_count:1 size:7939"}
{"level":"info","ts":"2026-09-01T19:24:04.361349Z","caller":"traceutil/trace.go:171","msg":"trace[220745853] range","detail":"{range_begin:/registry/jobs/openstack/cinder-create-internal-tenant; range_end:; response_count:1; response_revision:26914; }","duration":"102.454552ms","start":"2026-09-01T19:24:04.258878Z","end":"2026-09-01T19:24:04.361332Z","steps":["trace[220745853] 'agreement among raft nodes before linearized reading'  (duration: 101.858315ms)"],"step_count":1}
{"level":"info","ts":"2026-09-01T19:25:20.76466Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":25281}
{"level":"info","ts":"2026-09-01T19:25:20.93929Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":25281,"took":"169.89752ms","hash":3003094087,"current-db-size-bytes":56750080,"current-db-size":"57 MB","current-db-size-in-use-bytes":30121984,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-09-01T19:25:20.939366Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3003094087,"revision":25281,"compact-revision":22165}