{"level":"warn","ts":"2026-05-09T05:14:11.354585Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-05-09T05:14:11.354726Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.89:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.89:2380","--initial-cluster=instance=https://199.204.45.89:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.89:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.89: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-05-09T05:14:11.354807Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-05-09T05:14:11.354824Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.89:2380"]}
{"level":"info","ts":"2026-05-09T05:14:11.354855Z","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-05-09T05:14:11.355624Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.89:2379"]}
{"level":"info","ts":"2026-05-09T05:14:11.355723Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.89:2380"],"listen-peer-urls":["https://199.204.45.89:2380"],"advertise-client-urls":["https://199.204.45.89:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.89:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.89: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-05-09T05:14:11.359863Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.845355ms"}
{"level":"info","ts":"2026-05-09T05:14:11.371128Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"c3b8446219deb8c1","cluster-id":"fe02a46d8aa9751f"}
{"level":"info","ts":"2026-05-09T05:14:11.37124Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 switched to configuration voters=()"}
{"level":"info","ts":"2026-05-09T05:14:11.371268Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 became follower at term 0"}
{"level":"info","ts":"2026-05-09T05:14:11.37128Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft c3b8446219deb8c1 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-05-09T05:14:11.371294Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 became follower at term 1"}
{"level":"info","ts":"2026-05-09T05:14:11.371343Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 switched to configuration voters=(14103097421242218689)"}
{"level":"warn","ts":"2026-05-09T05:14:11.378217Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-05-09T05:14:11.379829Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-05-09T05:14:11.381085Z","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-05-09T05:14:11.383867Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"c3b8446219deb8c1","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-05-09T05:14:11.384063Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"c3b8446219deb8c1","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-05-09T05:14:11.38424Z","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-05-09T05:14:11.384422Z","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-05-09T05:14:11.384438Z","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-05-09T05:14:11.386288Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 switched to configuration voters=(14103097421242218689)"}
{"level":"info","ts":"2026-05-09T05:14:11.387104Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"fe02a46d8aa9751f","local-member-id":"c3b8446219deb8c1","added-peer-id":"c3b8446219deb8c1","added-peer-peer-urls":["https://199.204.45.89:2380"]}
{"level":"info","ts":"2026-05-09T05:14:11.389009Z","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-05-09T05:14:11.38918Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.89:2380"}
{"level":"info","ts":"2026-05-09T05:14:11.391059Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.89:2380"}
{"level":"info","ts":"2026-05-09T05:14:11.391172Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"c3b8446219deb8c1","initial-advertise-peer-urls":["https://199.204.45.89:2380"],"listen-peer-urls":["https://199.204.45.89:2380"],"advertise-client-urls":["https://199.204.45.89:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.89:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-05-09T05:14:11.391253Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-05-09T05:14:11.672103Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 is starting a new election at term 1"}
{"level":"info","ts":"2026-05-09T05:14:11.67218Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 became pre-candidate at term 1"}
{"level":"info","ts":"2026-05-09T05:14:11.672219Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 received MsgPreVoteResp from c3b8446219deb8c1 at term 1"}
{"level":"info","ts":"2026-05-09T05:14:11.672241Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 became candidate at term 2"}
{"level":"info","ts":"2026-05-09T05:14:11.672262Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 received MsgVoteResp from c3b8446219deb8c1 at term 2"}
{"level":"info","ts":"2026-05-09T05:14:11.672284Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 became leader at term 2"}
{"level":"info","ts":"2026-05-09T05:14:11.672299Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: c3b8446219deb8c1 elected leader c3b8446219deb8c1 at term 2"}
{"level":"info","ts":"2026-05-09T05:14:11.673297Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"c3b8446219deb8c1","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.89:2379]}","request-path":"/0/members/c3b8446219deb8c1/attributes","cluster-id":"fe02a46d8aa9751f","publish-timeout":"7s"}
{"level":"info","ts":"2026-05-09T05:14:11.673397Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-05-09T05:14:11.673526Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-05-09T05:14:11.673561Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-09T05:14:11.673791Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-05-09T05:14:11.673892Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-05-09T05:14:11.674572Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"fe02a46d8aa9751f","local-member-id":"c3b8446219deb8c1","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-09T05:14:11.674716Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-09T05:14:11.674778Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-09T05:14:11.677294Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.89:2379"}
{"level":"info","ts":"2026-05-09T05:14:11.677351Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-05-09T05:14:17.615498Z","caller":"traceutil/trace.go:171","msg":"trace[1707549571] linearizableReadLoop","detail":"{readStateIndex:281; appliedIndex:280; }","duration":"115.110999ms","start":"2026-05-09T05:14:17.500355Z","end":"2026-05-09T05:14:17.615466Z","steps":["trace[1707549571] 'read index received'  (duration: 91.925711ms)","trace[1707549571] 'applied index is now lower than readState.Index'  (duration: 23.183978ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T05:14:17.615641Z","caller":"traceutil/trace.go:171","msg":"trace[1473545437] transaction","detail":"{read_only:false; response_revision:273; number_of_response:1; }","duration":"154.020149ms","start":"2026-05-09T05:14:17.461587Z","end":"2026-05-09T05:14:17.615607Z","steps":["trace[1473545437] 'process raft request'  (duration: 130.81341ms)","trace[1473545437] 'compare'  (duration: 22.778038ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T05:14:17.61576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.344404ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"}
{"level":"info","ts":"2026-05-09T05:14:17.615914Z","caller":"traceutil/trace.go:171","msg":"trace[1065593002] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:273; }","duration":"115.583001ms","start":"2026-05-09T05:14:17.500316Z","end":"2026-05-09T05:14:17.615899Z","steps":["trace[1065593002] 'agreement among raft nodes before linearized reading'  (duration: 115.274083ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T05:14:23.601421Z","caller":"traceutil/trace.go:171","msg":"trace[149230233] linearizableReadLoop","detail":"{readStateIndex:366; appliedIndex:365; }","duration":"217.369368ms","start":"2026-05-09T05:14:23.384026Z","end":"2026-05-09T05:14:23.601395Z","steps":["trace[149230233] 'read index received'  (duration: 217.144062ms)","trace[149230233] 'applied index is now lower than readState.Index'  (duration: 224.486µs)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T05:14:23.60159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.546162ms","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-05-09T05:14:23.601629Z","caller":"traceutil/trace.go:171","msg":"trace[1330552593] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:354; }","duration":"217.668485ms","start":"2026-05-09T05:14:23.383945Z","end":"2026-05-09T05:14:23.601613Z","steps":["trace[1330552593] 'agreement among raft nodes before linearized reading'  (duration: 217.579193ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T05:14:23.60163Z","caller":"traceutil/trace.go:171","msg":"trace[955517820] transaction","detail":"{read_only:false; response_revision:354; number_of_response:1; }","duration":"232.697159ms","start":"2026-05-09T05:14:23.368869Z","end":"2026-05-09T05:14:23.601566Z","steps":["trace[955517820] 'process raft request'  (duration: 232.367441ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T05:14:23.764321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.947728ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13313095744241937968 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:348 > 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-05-09T05:14:23.764451Z","caller":"traceutil/trace.go:171","msg":"trace[1376120007] linearizableReadLoop","detail":"{readStateIndex:367; appliedIndex:366; }","duration":"124.651776ms","start":"2026-05-09T05:14:23.639783Z","end":"2026-05-09T05:14:23.764435Z","steps":["trace[1376120007] 'read index received'  (duration: 43.721µs)","trace[1376120007] 'applied index is now lower than readState.Index'  (duration: 124.607035ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T05:14:23.764527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.754159ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-05-09T05:14:23.764561Z","caller":"traceutil/trace.go:171","msg":"trace[1598361863] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:355; }","duration":"124.82823ms","start":"2026-05-09T05:14:23.639723Z","end":"2026-05-09T05:14:23.764551Z","steps":["trace[1598361863] 'agreement among raft nodes before linearized reading'  (duration: 124.758009ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T05:14:23.76452Z","caller":"traceutil/trace.go:171","msg":"trace[56094420] transaction","detail":"{read_only:false; response_revision:355; number_of_response:1; }","duration":"159.505186ms","start":"2026-05-09T05:14:23.604974Z","end":"2026-05-09T05:14:23.76448Z","steps":["trace[56094420] 'process raft request'  (duration: 16.814349ms)","trace[56094420] 'compare'  (duration: 141.775354ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T05:14:47.061301Z","caller":"traceutil/trace.go:171","msg":"trace[1228563894] transaction","detail":"{read_only:false; response_revision:572; number_of_response:1; }","duration":"127.248944ms","start":"2026-05-09T05:14:46.934022Z","end":"2026-05-09T05:14:47.061271Z","steps":["trace[1228563894] 'process raft request'  (duration: 127.09792ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T05:14:47.269684Z","caller":"traceutil/trace.go:171","msg":"trace[956432261] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"328.115963ms","start":"2026-05-09T05:14:46.941521Z","end":"2026-05-09T05:14:47.269637Z","steps":["trace[956432261] 'process raft request'  (duration: 289.420572ms)","trace[956432261] 'compare'  (duration: 38.25595ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T05:14:47.269997Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T05:14:46.941463Z","time spent":"328.321698ms","remote":"127.0.0.1:58574","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036281,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" mod_revision:569 > success:<request_put:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" value_size:1036197 >> failure:<request_range:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" > >"}
{"level":"warn","ts":"2026-05-09T05:14:47.747907Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.111263ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13313095744241938373 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" mod_revision:0 > success:<request_put:<key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" value_size:1527 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-05-09T05:14:47.74815Z","caller":"traceutil/trace.go:171","msg":"trace[781754285] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"422.449418ms","start":"2026-05-09T05:14:47.325664Z","end":"2026-05-09T05:14:47.748113Z","steps":["trace[781754285] 'process raft request'  (duration: 249.053248ms)","trace[781754285] 'compare'  (duration: 172.978128ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T05:14:47.748025Z","caller":"traceutil/trace.go:171","msg":"trace[790857804] linearizableReadLoop","detail":"{readStateIndex:601; appliedIndex:600; }","duration":"378.454559ms","start":"2026-05-09T05:14:47.369548Z","end":"2026-05-09T05:14:47.748003Z","steps":["trace[790857804] 'read index received'  (duration: 205.162551ms)","trace[790857804] 'applied index is now lower than readState.Index'  (duration: 173.289868ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T05:14:47.748285Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T05:14:47.325645Z","time spent":"422.576101ms","remote":"127.0.0.1:58968","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" mod_revision:0 > success:<request_put:<key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" value_size:1527 >> failure:<>"}
{"level":"warn","ts":"2026-05-09T05:14:47.748491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.88219ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-05-09T05:14:47.748579Z","caller":"traceutil/trace.go:171","msg":"trace[1480402410] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:576; }","duration":"379.020683ms","start":"2026-05-09T05:14:47.369542Z","end":"2026-05-09T05:14:47.748563Z","steps":["trace[1480402410] 'agreement among raft nodes before linearized reading'  (duration: 378.699345ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T05:14:47.748619Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T05:14:47.369491Z","time spent":"379.119686ms","remote":"127.0.0.1:58736","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":"info","ts":"2026-05-09T05:14:47.754856Z","caller":"traceutil/trace.go:171","msg":"trace[624675235] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"127.83944ms","start":"2026-05-09T05:14:47.626993Z","end":"2026-05-09T05:14:47.754833Z","steps":["trace[624675235] 'process raft request'  (duration: 127.726807ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T05:15:02.155714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.040168ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-74p6c\" ","response":"range_response_count:1 size:3964"}
{"level":"warn","ts":"2026-05-09T05:15:02.155694Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.284575ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-05-09T05:15:02.155817Z","caller":"traceutil/trace.go:171","msg":"trace[2123165828] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-74p6c; range_end:; response_count:1; response_revision:731; }","duration":"148.239703ms","start":"2026-05-09T05:15:02.007557Z","end":"2026-05-09T05:15:02.155797Z","steps":["trace[2123165828] 'range keys from in-memory index tree'  (duration: 147.785692ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T05:15:02.155845Z","caller":"traceutil/trace.go:171","msg":"trace[1402858315] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:731; }","duration":"109.48481ms","start":"2026-05-09T05:15:02.04633Z","end":"2026-05-09T05:15:02.155815Z","steps":["trace[1402858315] 'range keys from in-memory index tree'  (duration: 109.07235ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T05:15:02.155694Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.439718ms","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-05-09T05:15:02.155962Z","caller":"traceutil/trace.go:171","msg":"trace[1043772757] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:731; }","duration":"192.777667ms","start":"2026-05-09T05:15:01.963165Z","end":"2026-05-09T05:15:02.155942Z","steps":["trace[1043772757] 'range keys from in-memory index tree'  (duration: 192.282144ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T05:15:49.164911Z","caller":"traceutil/trace.go:171","msg":"trace[326075984] transaction","detail":"{read_only:false; response_revision:1283; number_of_response:1; }","duration":"141.881634ms","start":"2026-05-09T05:15:49.023004Z","end":"2026-05-09T05:15:49.164885Z","steps":["trace[326075984] 'process raft request'  (duration: 141.684569ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T05:16:19.092726Z","caller":"traceutil/trace.go:171","msg":"trace[914029276] linearizableReadLoop","detail":"{readStateIndex:1881; appliedIndex:1880; }","duration":"133.408089ms","start":"2026-05-09T05:16:18.959274Z","end":"2026-05-09T05:16:19.092682Z","steps":["trace[914029276] 'read index received'  (duration: 132.912174ms)","trace[914029276] 'applied index is now lower than readState.Index'  (duration: 494.165µs)"],"step_count":2}
{"level":"info","ts":"2026-05-09T05:16:19.092804Z","caller":"traceutil/trace.go:171","msg":"trace[1513142710] transaction","detail":"{read_only:false; response_revision:1809; number_of_response:1; }","duration":"146.229216ms","start":"2026-05-09T05:16:18.946526Z","end":"2026-05-09T05:16:19.092756Z","steps":["trace[1513142710] 'process raft request'  (duration: 145.861025ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T05:16:19.09305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.735009ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-77662718-bdcf-48ed-94f3-3a1178dc9f73\" ","response":"range_response_count:1 size:3626"}
{"level":"info","ts":"2026-05-09T05:16:19.093109Z","caller":"traceutil/trace.go:171","msg":"trace[697408575] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-77662718-bdcf-48ed-94f3-3a1178dc9f73; range_end:; response_count:1; response_revision:1809; }","duration":"133.855861ms","start":"2026-05-09T05:16:18.959236Z","end":"2026-05-09T05:16:19.093092Z","steps":["trace[697408575] 'agreement among raft nodes before linearized reading'  (duration: 133.608775ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T05:16:19.437219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.293966ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"}
{"level":"info","ts":"2026-05-09T05:16:19.437333Z","caller":"traceutil/trace.go:171","msg":"trace[1036424841] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1810; }","duration":"188.481741ms","start":"2026-05-09T05:16:19.248825Z","end":"2026-05-09T05:16:19.437307Z","steps":["trace[1036424841] 'range keys from in-memory index tree'  (duration: 188.06869ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T05:16:19.437569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.379171ms","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:7"}
{"level":"info","ts":"2026-05-09T05:16:19.437641Z","caller":"traceutil/trace.go:171","msg":"trace[1661323303] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:1810; }","duration":"169.505494ms","start":"2026-05-09T05:16:19.268116Z","end":"2026-05-09T05:16:19.437621Z","steps":["trace[1661323303] 'count revisions from in-memory index tree'  (duration: 169.289567ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T05:17:14.789096Z","caller":"traceutil/trace.go:171","msg":"trace[1191905730] linearizableReadLoop","detail":"{readStateIndex:2240; appliedIndex:2239; }","duration":"192.751541ms","start":"2026-05-09T05:17:14.596301Z","end":"2026-05-09T05:17:14.789053Z","steps":["trace[1191905730] 'read index received'  (duration: 192.532185ms)","trace[1191905730] 'applied index is now lower than readState.Index'  (duration: 217.836µs)"],"step_count":2}
{"level":"info","ts":"2026-05-09T05:17:14.789205Z","caller":"traceutil/trace.go:171","msg":"trace[386891264] transaction","detail":"{read_only:false; response_revision:2157; number_of_response:1; }","duration":"256.300561ms","start":"2026-05-09T05:17:14.532868Z","end":"2026-05-09T05:17:14.789169Z","steps":["trace[386891264] 'process raft request'  (duration: 255.949721ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T05:17:14.789381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.05303ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-05-09T05:17:14.789489Z","caller":"traceutil/trace.go:171","msg":"trace[1997795303] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2157; }","duration":"193.191873ms","start":"2026-05-09T05:17:14.596256Z","end":"2026-05-09T05:17:14.789448Z","steps":["trace[1997795303] 'agreement among raft nodes before linearized reading'  (duration: 192.957067ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T05:17:14.936577Z","caller":"traceutil/trace.go:171","msg":"trace[767330726] linearizableReadLoop","detail":"{readStateIndex:2242; appliedIndex:2241; }","duration":"113.543114ms","start":"2026-05-09T05:17:14.823011Z","end":"2026-05-09T05:17:14.936554Z","steps":["trace[767330726] 'read index received'  (duration: 113.348309ms)","trace[767330726] 'applied index is now lower than readState.Index'  (duration: 193.975µs)"],"step_count":2}
{"level":"info","ts":"2026-05-09T05:17:14.936637Z","caller":"traceutil/trace.go:171","msg":"trace[1775076282] transaction","detail":"{read_only:false; response_revision:2159; number_of_response:1; }","duration":"142.269444ms","start":"2026-05-09T05:17:14.794332Z","end":"2026-05-09T05:17:14.936601Z","steps":["trace[1775076282] 'process raft request'  (duration: 142.070809ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T05:17:14.93687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.844533ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.89\" ","response":"range_response_count:1 size:133"}
{"level":"info","ts":"2026-05-09T05:17:14.936915Z","caller":"traceutil/trace.go:171","msg":"trace[977003741] range","detail":"{range_begin:/registry/masterleases/199.204.45.89; range_end:; response_count:1; response_revision:2159; }","duration":"113.983637ms","start":"2026-05-09T05:17:14.82292Z","end":"2026-05-09T05:17:14.936904Z","steps":["trace[977003741] 'agreement among raft nodes before linearized reading'  (duration: 113.775881ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T05:17:14.937043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.13332ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-05-09T05:17:14.937077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.903493ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-05-09T05:17:14.93713Z","caller":"traceutil/trace.go:171","msg":"trace[1877100363] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2159; }","duration":"109.987285ms","start":"2026-05-09T05:17:14.827131Z","end":"2026-05-09T05:17:14.937119Z","steps":["trace[1877100363] 'agreement among raft nodes before linearized reading'  (duration: 109.81445ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T05:17:14.937123Z","caller":"traceutil/trace.go:171","msg":"trace[500978680] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2159; }","duration":"105.257033ms","start":"2026-05-09T05:17:14.831839Z","end":"2026-05-09T05:17:14.937096Z","steps":["trace[500978680] 'agreement among raft nodes before linearized reading'  (duration: 105.116609ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T05:17:14.937079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.545713ms","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-05-09T05:17:14.937285Z","caller":"traceutil/trace.go:171","msg":"trace[1132127372] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2159; }","duration":"113.769839ms","start":"2026-05-09T05:17:14.823474Z","end":"2026-05-09T05:17:14.937244Z","steps":["trace[1132127372] 'agreement among raft nodes before linearized reading'  (duration: 113.486121ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T05:17:50.05653Z","caller":"traceutil/trace.go:171","msg":"trace[2077505159] transaction","detail":"{read_only:false; response_revision:2524; number_of_response:1; }","duration":"182.2908ms","start":"2026-05-09T05:17:49.874217Z","end":"2026-05-09T05:17:50.056507Z","steps":["trace[2077505159] 'process raft request'  (duration: 182.164736ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T05:18:23.77728Z","caller":"traceutil/trace.go:171","msg":"trace[1355695383] linearizableReadLoop","detail":"{readStateIndex:2834; appliedIndex:2833; }","duration":"107.044319ms","start":"2026-05-09T05:18:23.670187Z","end":"2026-05-09T05:18:23.777231Z","steps":["trace[1355695383] 'read index received'  (duration: 106.847044ms)","trace[1355695383] 'applied index is now lower than readState.Index'  (duration: 196.075µs)"],"step_count":2}
{"level":"info","ts":"2026-05-09T05:18:23.77733Z","caller":"traceutil/trace.go:171","msg":"trace[886896825] transaction","detail":"{read_only:false; response_revision:2729; number_of_response:1; }","duration":"108.865619ms","start":"2026-05-09T05:18:23.668437Z","end":"2026-05-09T05:18:23.777303Z","steps":["trace[886896825] 'process raft request'  (duration: 108.665453ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T05:18:23.781511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.083714ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-09T05:18:23.781639Z","caller":"traceutil/trace.go:171","msg":"trace[1450837955] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2729; }","duration":"105.27204ms","start":"2026-05-09T05:18:23.676347Z","end":"2026-05-09T05:18:23.781619Z","steps":["trace[1450837955] 'agreement among raft nodes before linearized reading'  (duration: 101.058165ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T05:18:23.781783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.556092ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/auth-system/keycloak\" ","response":"range_response_count:1 size:7462"}
{"level":"info","ts":"2026-05-09T05:18:23.78187Z","caller":"traceutil/trace.go:171","msg":"trace[685409197] range","detail":"{range_begin:/registry/statefulsets/auth-system/keycloak; range_end:; response_count:1; response_revision:2729; }","duration":"111.716397ms","start":"2026-05-09T05:18:23.670136Z","end":"2026-05-09T05:18:23.781852Z","steps":["trace[685409197] 'agreement among raft nodes before linearized reading'  (duration: 107.247495ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T05:20:48.238424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.206278ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-k7g5p\" ","response":"range_response_count:1 size:6527"}
{"level":"info","ts":"2026-05-09T05:20:48.238537Z","caller":"traceutil/trace.go:171","msg":"trace[1378851701] range","detail":"{range_begin:/registry/pods/openstack/keepalived-k7g5p; range_end:; response_count:1; response_revision:3691; }","duration":"113.361633ms","start":"2026-05-09T05:20:48.125148Z","end":"2026-05-09T05:20:48.23851Z","steps":["trace[1378851701] 'range keys from in-memory index tree'  (duration: 113.027663ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T05:20:48.394456Z","caller":"traceutil/trace.go:171","msg":"trace[1171901679] transaction","detail":"{read_only:false; response_revision:3692; number_of_response:1; }","duration":"108.421789ms","start":"2026-05-09T05:20:48.286009Z","end":"2026-05-09T05:20:48.394431Z","steps":["trace[1171901679] 'process raft request'  (duration: 108.253744ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T05:22:07.324183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.438645ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-823980ed-8fc1-4b13-95ed-41e008ebca3f\" ","response":"range_response_count:1 size:4079"}
{"level":"info","ts":"2026-05-09T05:22:07.324291Z","caller":"traceutil/trace.go:171","msg":"trace[749611451] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-823980ed-8fc1-4b13-95ed-41e008ebca3f; range_end:; response_count:1; response_revision:4719; }","duration":"104.606129ms","start":"2026-05-09T05:22:07.219662Z","end":"2026-05-09T05:22:07.324268Z","steps":["trace[749611451] 'range keys from in-memory index tree'  (duration: 104.171497ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T05:22:10.194128Z","caller":"traceutil/trace.go:171","msg":"trace[702034563] transaction","detail":"{read_only:false; response_revision:4865; number_of_response:1; }","duration":"143.392141ms","start":"2026-05-09T05:22:10.050709Z","end":"2026-05-09T05:22:10.194102Z","steps":["trace[702034563] 'process raft request'  (duration: 143.095003ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T05:22:10.34562Z","caller":"traceutil/trace.go:171","msg":"trace[740296937] transaction","detail":"{read_only:false; response_revision:4866; number_of_response:1; }","duration":"148.754287ms","start":"2026-05-09T05:22:10.196834Z","end":"2026-05-09T05:22:10.345588Z","steps":["trace[740296937] 'process raft request'  (duration: 59.393631ms)","trace[740296937] 'compare'  (duration: 89.192582ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T05:22:10.376369Z","caller":"traceutil/trace.go:171","msg":"trace[1534940966] transaction","detail":"{read_only:false; response_revision:4867; number_of_response:1; }","duration":"173.574431ms","start":"2026-05-09T05:22:10.202756Z","end":"2026-05-09T05:22:10.376331Z","steps":["trace[1534940966] 'process raft request'  (duration: 173.336005ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T05:22:10.376449Z","caller":"traceutil/trace.go:171","msg":"trace[734093156] transaction","detail":"{read_only:false; response_revision:4868; number_of_response:1; }","duration":"131.92073ms","start":"2026-05-09T05:22:10.24451Z","end":"2026-05-09T05:22:10.376431Z","steps":["trace[734093156] 'process raft request'  (duration: 131.689334ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T05:22:18.442164Z","caller":"traceutil/trace.go:171","msg":"trace[903435754] transaction","detail":"{read_only:false; response_revision:5034; number_of_response:1; }","duration":"119.194325ms","start":"2026-05-09T05:22:18.322929Z","end":"2026-05-09T05:22:18.442123Z","steps":["trace[903435754] 'process raft request'  (duration: 118.928047ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T05:22:18.44238Z","caller":"traceutil/trace.go:171","msg":"trace[807783847] transaction","detail":"{read_only:false; response_revision:5035; number_of_response:1; }","duration":"118.433994ms","start":"2026-05-09T05:22:18.323924Z","end":"2026-05-09T05:22:18.442358Z","steps":["trace[807783847] 'process raft request'  (duration: 118.127316ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T05:22:18.442483Z","caller":"traceutil/trace.go:171","msg":"trace[1434298449] transaction","detail":"{read_only:false; response_revision:5036; number_of_response:1; }","duration":"117.412956ms","start":"2026-05-09T05:22:18.325044Z","end":"2026-05-09T05:22:18.442457Z","steps":["trace[1434298449] 'process raft request'  (duration: 117.258642ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T05:22:18.443187Z","caller":"traceutil/trace.go:171","msg":"trace[285463311] transaction","detail":"{read_only:false; response_revision:5037; number_of_response:1; }","duration":"117.933471ms","start":"2026-05-09T05:22:18.32521Z","end":"2026-05-09T05:22:18.443144Z","steps":["trace[285463311] 'process raft request'  (duration: 117.222391ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T05:22:21.663202Z","caller":"traceutil/trace.go:171","msg":"trace[1699607326] transaction","detail":"{read_only:false; response_revision:5100; number_of_response:1; }","duration":"151.237427ms","start":"2026-05-09T05:22:21.511916Z","end":"2026-05-09T05:22:21.663154Z","steps":["trace[1699607326] 'process raft request'  (duration: 150.890828ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T05:22:29.72441Z","caller":"traceutil/trace.go:171","msg":"trace[552403389] linearizableReadLoop","detail":"{readStateIndex:5464; appliedIndex:5463; }","duration":"236.136389ms","start":"2026-05-09T05:22:29.488252Z","end":"2026-05-09T05:22:29.724388Z","steps":["trace[552403389] 'read index received'  (duration: 235.932042ms)","trace[552403389] 'applied index is now lower than readState.Index'  (duration: 203.037µs)"],"step_count":2}
{"level":"info","ts":"2026-05-09T05:22:29.724485Z","caller":"traceutil/trace.go:171","msg":"trace[1702138734] transaction","detail":"{read_only:false; response_revision:5272; number_of_response:1; }","duration":"284.601789ms","start":"2026-05-09T05:22:29.439851Z","end":"2026-05-09T05:22:29.724453Z","steps":["trace[1702138734] 'process raft request'  (duration: 284.399533ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T05:22:29.724622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.351756ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"}
{"level":"info","ts":"2026-05-09T05:22:29.724664Z","caller":"traceutil/trace.go:171","msg":"trace[1980127456] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5272; }","duration":"236.432857ms","start":"2026-05-09T05:22:29.488221Z","end":"2026-05-09T05:22:29.724654Z","steps":["trace[1980127456] 'agreement among raft nodes before linearized reading'  (duration: 236.293973ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T05:22:29.724755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.286366ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"}
{"level":"info","ts":"2026-05-09T05:22:29.724837Z","caller":"traceutil/trace.go:171","msg":"trace[351363863] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5272; }","duration":"235.411928ms","start":"2026-05-09T05:22:29.489406Z","end":"2026-05-09T05:22:29.724818Z","steps":["trace[351363863] 'agreement among raft nodes before linearized reading'  (duration: 235.149791ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T05:22:29.937523Z","caller":"traceutil/trace.go:171","msg":"trace[1324609934] linearizableReadLoop","detail":"{readStateIndex:5466; appliedIndex:5464; }","duration":"109.210583ms","start":"2026-05-09T05:22:29.828292Z","end":"2026-05-09T05:22:29.937503Z","steps":["trace[1324609934] 'read index received'  (duration: 36.489503ms)","trace[1324609934] 'applied index is now lower than readState.Index'  (duration: 72.71974ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T05:22:29.937681Z","caller":"traceutil/trace.go:171","msg":"trace[1217317697] transaction","detail":"{read_only:false; response_revision:5274; number_of_response:1; }","duration":"208.110817ms","start":"2026-05-09T05:22:29.729545Z","end":"2026-05-09T05:22:29.937656Z","steps":["trace[1217317697] 'process raft request'  (duration: 207.900991ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T05:22:29.937781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.482701ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-09T05:22:29.937817Z","caller":"traceutil/trace.go:171","msg":"trace[1036101706] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5274; }","duration":"109.571293ms","start":"2026-05-09T05:22:29.828236Z","end":"2026-05-09T05:22:29.937807Z","steps":["trace[1036101706] 'agreement among raft nodes before linearized reading'  (duration: 109.504491ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T05:22:29.937922Z","caller":"traceutil/trace.go:171","msg":"trace[226024846] transaction","detail":"{read_only:false; response_revision:5273; number_of_response:1; }","duration":"209.027471ms","start":"2026-05-09T05:22:29.728863Z","end":"2026-05-09T05:22:29.937891Z","steps":["trace[226024846] 'process raft request'  (duration: 135.851359ms)","trace[226024846] 'compare'  (duration: 72.633167ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T05:24:11.715697Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2993}
{"level":"info","ts":"2026-05-09T05:24:11.787498Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2993,"took":"70.334707ms","hash":1480026254,"current-db-size-bytes":59125760,"current-db-size":"59 MB","current-db-size-in-use-bytes":34070528,"current-db-size-in-use":"34 MB"}
{"level":"info","ts":"2026-05-09T05:24:11.787571Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1480026254,"revision":2993,"compact-revision":-1}
{"level":"info","ts":"2026-05-09T05:28:45.617959Z","caller":"traceutil/trace.go:171","msg":"trace[2092518711] transaction","detail":"{read_only:false; response_revision:8155; number_of_response:1; }","duration":"138.076302ms","start":"2026-05-09T05:28:45.479853Z","end":"2026-05-09T05:28:45.617929Z","steps":["trace[2092518711] 'process raft request'  (duration: 134.535948ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T05:28:46.367781Z","caller":"traceutil/trace.go:171","msg":"trace[1149239973] transaction","detail":"{read_only:false; response_revision:8157; number_of_response:1; }","duration":"350.491653ms","start":"2026-05-09T05:28:46.017237Z","end":"2026-05-09T05:28:46.367729Z","steps":["trace[1149239973] 'process raft request'  (duration: 264.709468ms)","trace[1149239973] 'compare'  (duration: 85.615201ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T05:28:46.367864Z","caller":"traceutil/trace.go:171","msg":"trace[1546445585] transaction","detail":"{read_only:false; response_revision:8159; number_of_response:1; }","duration":"103.877323ms","start":"2026-05-09T05:28:46.263968Z","end":"2026-05-09T05:28:46.367845Z","steps":["trace[1546445585] 'process raft request'  (duration: 103.822211ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T05:28:46.367991Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T05:28:46.017191Z","time spent":"350.69286ms","remote":"127.0.0.1:58736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:8145 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-05-09T05:28:46.367956Z","caller":"traceutil/trace.go:171","msg":"trace[2094210941] transaction","detail":"{read_only:false; response_revision:8158; number_of_response:1; }","duration":"149.706955ms","start":"2026-05-09T05:28:46.218213Z","end":"2026-05-09T05:28:46.36792Z","steps":["trace[2094210941] 'process raft request'  (duration: 149.495439ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T05:28:46.367963Z","caller":"traceutil/trace.go:171","msg":"trace[1748692612] linearizableReadLoop","detail":"{readStateIndex:8441; appliedIndex:8439; }","duration":"339.998332ms","start":"2026-05-09T05:28:46.027872Z","end":"2026-05-09T05:28:46.36787Z","steps":["trace[1748692612] 'read index received'  (duration: 75.220142ms)","trace[1748692612] 'applied index is now lower than readState.Index'  (duration: 264.77401ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T05:28:46.368219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.99931ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-09T05:28:46.368262Z","caller":"traceutil/trace.go:171","msg":"trace[1156000489] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:8159; }","duration":"106.090293ms","start":"2026-05-09T05:28:46.262159Z","end":"2026-05-09T05:28:46.368249Z","steps":["trace[1156000489] 'agreement among raft nodes before linearized reading'  (duration: 106.014211ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T05:28:46.368746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.838605ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"}
{"level":"info","ts":"2026-05-09T05:28:46.368829Z","caller":"traceutil/trace.go:171","msg":"trace[884760129] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8159; }","duration":"340.975198ms","start":"2026-05-09T05:28:46.027836Z","end":"2026-05-09T05:28:46.368811Z","steps":["trace[884760129] 'agreement among raft nodes before linearized reading'  (duration: 340.208738ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T05:28:46.368879Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T05:28:46.027821Z","time spent":"341.04543ms","remote":"127.0.0.1:58736","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":579,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"info","ts":"2026-05-09T05:28:48.499661Z","caller":"traceutil/trace.go:171","msg":"trace[2047928969] transaction","detail":"{read_only:false; response_revision:8167; number_of_response:1; }","duration":"125.854003ms","start":"2026-05-09T05:28:48.373777Z","end":"2026-05-09T05:28:48.499631Z","steps":["trace[2047928969] 'process raft request'  (duration: 125.667068ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T05:28:48.500177Z","caller":"traceutil/trace.go:171","msg":"trace[2031632905] linearizableReadLoop","detail":"{readStateIndex:8452; appliedIndex:8450; }","duration":"116.063141ms","start":"2026-05-09T05:28:48.38409Z","end":"2026-05-09T05:28:48.500153Z","steps":["trace[2031632905] 'read index received'  (duration: 115.452614ms)","trace[2031632905] 'applied index is now lower than readState.Index'  (duration: 609.397µs)"],"step_count":2}
{"level":"info","ts":"2026-05-09T05:28:48.50032Z","caller":"traceutil/trace.go:171","msg":"trace[1995096286] transaction","detail":"{read_only:false; response_revision:8168; number_of_response:1; }","duration":"125.009222ms","start":"2026-05-09T05:28:48.3753Z","end":"2026-05-09T05:28:48.500309Z","steps":["trace[1995096286] 'process raft request'  (duration: 124.723034ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T05:28:48.500802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.689328ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"}
{"level":"info","ts":"2026-05-09T05:28:48.500844Z","caller":"traceutil/trace.go:171","msg":"trace[341723290] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8168; }","duration":"116.77518ms","start":"2026-05-09T05:28:48.384053Z","end":"2026-05-09T05:28:48.500829Z","steps":["trace[341723290] 'agreement among raft nodes before linearized reading'  (duration: 116.632816ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T05:29:11.725507Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6176}
{"level":"info","ts":"2026-05-09T05:29:11.836717Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6176,"took":"109.079063ms","hash":2924869957,"current-db-size-bytes":59125760,"current-db-size":"59 MB","current-db-size-in-use-bytes":23048192,"current-db-size-in-use":"23 MB"}
{"level":"info","ts":"2026-05-09T05:29:11.836793Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2924869957,"revision":6176,"compact-revision":2993}
{"level":"info","ts":"2026-05-09T05:29:16.529689Z","caller":"traceutil/trace.go:171","msg":"trace[598534393] transaction","detail":"{read_only:false; response_revision:8374; number_of_response:1; }","duration":"256.695432ms","start":"2026-05-09T05:29:16.27296Z","end":"2026-05-09T05:29:16.529655Z","steps":["trace[598534393] 'process raft request'  (duration: 256.479326ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T05:29:16.734914Z","caller":"traceutil/trace.go:171","msg":"trace[654223611] transaction","detail":"{read_only:false; response_revision:8375; number_of_response:1; }","duration":"120.731886ms","start":"2026-05-09T05:29:16.613426Z","end":"2026-05-09T05:29:16.734158Z","steps":["trace[654223611] 'process raft request'  (duration: 65.962654ms)","trace[654223611] 'compare'  (duration: 54.584758ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T05:29:18.671021Z","caller":"traceutil/trace.go:171","msg":"trace[1423042532] transaction","detail":"{read_only:false; response_revision:8384; number_of_response:1; }","duration":"119.672048ms","start":"2026-05-09T05:29:18.551316Z","end":"2026-05-09T05:29:18.670988Z","steps":["trace[1423042532] 'process raft request'  (duration: 119.488933ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T05:29:28.988281Z","caller":"traceutil/trace.go:171","msg":"trace[2006914379] transaction","detail":"{read_only:false; number_of_response:1; response_revision:8484; }","duration":"118.204489ms","start":"2026-05-09T05:29:28.870038Z","end":"2026-05-09T05:29:28.988243Z","steps":["trace[2006914379] 'process raft request'  (duration: 106.637208ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T05:29:28.992545Z","caller":"traceutil/trace.go:171","msg":"trace[479662754] transaction","detail":"{read_only:false; response_revision:8485; number_of_response:1; }","duration":"120.756207ms","start":"2026-05-09T05:29:28.871761Z","end":"2026-05-09T05:29:28.992518Z","steps":["trace[479662754] 'process raft request'  (duration: 120.633133ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T05:30:15.112648Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000023fb.wal"}
{"level":"info","ts":"2026-05-09T05:31:45.573996Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"c3b8446219deb8c1","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-05-09T05:31:45.580428Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-05-09T05:31:45.580531Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"warn","ts":"2026-05-09T05:33:05.667275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.239829ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13313095744241962628 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/replicasets/openstack/staffeln-conductor-56dbcd7886\" mod_revision:10231 > success:<request_put:<key:\"/registry/replicasets/openstack/staffeln-conductor-56dbcd7886\" value_size:4732 >> failure:<request_range:<key:\"/registry/replicasets/openstack/staffeln-conductor-56dbcd7886\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-09T05:33:05.667426Z","caller":"traceutil/trace.go:171","msg":"trace[1732564356] transaction","detail":"{read_only:false; response_revision:10295; number_of_response:1; }","duration":"128.336304ms","start":"2026-05-09T05:33:05.53906Z","end":"2026-05-09T05:33:05.667397Z","steps":["trace[1732564356] 'process raft request'  (duration: 21.8572ms)","trace[1732564356] 'compare'  (duration: 106.115325ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T05:34:11.732833Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8331}
{"level":"info","ts":"2026-05-09T05:34:11.818139Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8331,"took":"81.994506ms","hash":3360940227,"current-db-size-bytes":59125760,"current-db-size":"59 MB","current-db-size-in-use-bytes":26505216,"current-db-size-in-use":"26 MB"}
{"level":"info","ts":"2026-05-09T05:34:11.818226Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3360940227,"revision":8331,"compact-revision":6176}
{"level":"info","ts":"2026-05-09T05:34:30.222061Z","caller":"traceutil/trace.go:171","msg":"trace[90882717] transaction","detail":"{read_only:false; response_revision:11087; number_of_response:1; }","duration":"153.488512ms","start":"2026-05-09T05:34:30.068539Z","end":"2026-05-09T05:34:30.222027Z","steps":["trace[90882717] 'process raft request'  (duration: 153.256236ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T05:34:30.596569Z","caller":"traceutil/trace.go:171","msg":"trace[1043158698] linearizableReadLoop","detail":"{readStateIndex:11464; appliedIndex:11463; }","duration":"155.738362ms","start":"2026-05-09T05:34:30.440793Z","end":"2026-05-09T05:34:30.596531Z","steps":["trace[1043158698] 'read index received'  (duration: 140.492904ms)","trace[1043158698] 'applied index is now lower than readState.Index'  (duration: 15.243918ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T05:34:30.597002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.865241ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"}
{"level":"warn","ts":"2026-05-09T05:34:30.597016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.222645ms","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-05-09T05:34:30.597059Z","caller":"traceutil/trace.go:171","msg":"trace[425724239] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:11087; }","duration":"147.952273ms","start":"2026-05-09T05:34:30.449092Z","end":"2026-05-09T05:34:30.597044Z","steps":["trace[425724239] 'agreement among raft nodes before linearized reading'  (duration: 147.652465ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T05:34:30.597015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.693805ms","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-05-09T05:34:30.597126Z","caller":"traceutil/trace.go:171","msg":"trace[1716098235] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:11087; }","duration":"135.845519ms","start":"2026-05-09T05:34:30.461258Z","end":"2026-05-09T05:34:30.597103Z","steps":["trace[1716098235] 'agreement among raft nodes before linearized reading'  (duration: 135.541061ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T05:34:30.597072Z","caller":"traceutil/trace.go:171","msg":"trace[863436155] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:11087; }","duration":"156.331558ms","start":"2026-05-09T05:34:30.440724Z","end":"2026-05-09T05:34:30.597056Z","steps":["trace[863436155] 'agreement among raft nodes before linearized reading'  (duration: 155.937368ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T05:34:30.597358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.58777ms","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-05-09T05:34:30.597513Z","caller":"traceutil/trace.go:171","msg":"trace[226434999] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:11087; }","duration":"139.765003ms","start":"2026-05-09T05:34:30.457683Z","end":"2026-05-09T05:34:30.597448Z","steps":["trace[226434999] 'agreement among raft nodes before linearized reading'  (duration: 139.386374ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T05:34:30.597607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.57276ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"}
{"level":"warn","ts":"2026-05-09T05:34:30.597562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.457822ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"}
{"level":"info","ts":"2026-05-09T05:34:30.597659Z","caller":"traceutil/trace.go:171","msg":"trace[407318049] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:11087; }","duration":"123.653202ms","start":"2026-05-09T05:34:30.473994Z","end":"2026-05-09T05:34:30.597647Z","steps":["trace[407318049] 'agreement among raft nodes before linearized reading'  (duration: 123.291742ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T05:34:30.597707Z","caller":"traceutil/trace.go:171","msg":"trace[853826424] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:11087; }","duration":"140.677118ms","start":"2026-05-09T05:34:30.456996Z","end":"2026-05-09T05:34:30.597673Z","steps":["trace[853826424] 'agreement among raft nodes before linearized reading'  (duration: 140.254897ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T05:39:11.739756Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10981}
{"level":"info","ts":"2026-05-09T05:39:11.826943Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10981,"took":"84.333463ms","hash":4093206111,"current-db-size-bytes":59125760,"current-db-size":"59 MB","current-db-size-in-use-bytes":27983872,"current-db-size-in-use":"28 MB"}
{"level":"info","ts":"2026-05-09T05:39:11.827038Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4093206111,"revision":10981,"compact-revision":8331}
{"level":"info","ts":"2026-05-09T05:40:18.747707Z","caller":"traceutil/trace.go:171","msg":"trace[2119697405] linearizableReadLoop","detail":"{readStateIndex:13925; appliedIndex:13924; }","duration":"112.958252ms","start":"2026-05-09T05:40:18.634723Z","end":"2026-05-09T05:40:18.747681Z","steps":["trace[2119697405] 'read index received'  (duration: 112.781687ms)","trace[2119697405] 'applied index is now lower than readState.Index'  (duration: 175.775µs)"],"step_count":2}
{"level":"info","ts":"2026-05-09T05:40:18.748002Z","caller":"traceutil/trace.go:171","msg":"trace[1813847262] transaction","detail":"{read_only:false; response_revision:13467; number_of_response:1; }","duration":"117.802131ms","start":"2026-05-09T05:40:18.630188Z","end":"2026-05-09T05:40:18.74799Z","steps":["trace[1813847262] 'process raft request'  (duration: 117.37202ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T05:40:18.748268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.520837ms","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-05-09T05:40:18.748308Z","caller":"traceutil/trace.go:171","msg":"trace[53425037] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:13467; }","duration":"113.598379ms","start":"2026-05-09T05:40:18.634701Z","end":"2026-05-09T05:40:18.748299Z","steps":["trace[53425037] 'agreement among raft nodes before linearized reading'  (duration: 113.457876ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T05:40:18.748623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.432004ms","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-05-09T05:40:18.748671Z","caller":"traceutil/trace.go:171","msg":"trace[1407135751] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:13467; }","duration":"113.497635ms","start":"2026-05-09T05:40:18.635161Z","end":"2026-05-09T05:40:18.748659Z","steps":["trace[1407135751] 'agreement among raft nodes before linearized reading'  (duration: 113.264549ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T05:40:18.749108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.71499ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"}
{"level":"info","ts":"2026-05-09T05:40:18.749151Z","caller":"traceutil/trace.go:171","msg":"trace[610252870] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:13467; }","duration":"107.771452ms","start":"2026-05-09T05:40:18.641367Z","end":"2026-05-09T05:40:18.749138Z","steps":["trace[610252870] 'agreement among raft nodes before linearized reading'  (duration: 107.678719ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T05:40:18.749319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.859082ms","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-05-09T05:40:18.749353Z","caller":"traceutil/trace.go:171","msg":"trace[185327420] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:13467; }","duration":"111.913373ms","start":"2026-05-09T05:40:18.637431Z","end":"2026-05-09T05:40:18.749345Z","steps":["trace[185327420] 'agreement among raft nodes before linearized reading'  (duration: 111.834861ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T05:40:57.731708Z","caller":"traceutil/trace.go:171","msg":"trace[590050460] linearizableReadLoop","detail":"{readStateIndex:14154; appliedIndex:14153; }","duration":"174.938264ms","start":"2026-05-09T05:40:57.556734Z","end":"2026-05-09T05:40:57.731672Z","steps":["trace[590050460] 'read index received'  (duration: 174.616035ms)","trace[590050460] 'applied index is now lower than readState.Index'  (duration: 320.479µs)"],"step_count":2}
{"level":"info","ts":"2026-05-09T05:40:57.73179Z","caller":"traceutil/trace.go:171","msg":"trace[1823638142] transaction","detail":"{read_only:false; response_revision:13686; number_of_response:1; }","duration":"259.42054ms","start":"2026-05-09T05:40:57.472339Z","end":"2026-05-09T05:40:57.73176Z","steps":["trace[1823638142] 'process raft request'  (duration: 259.094671ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T05:40:57.732057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.456893ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:559"}
{"level":"info","ts":"2026-05-09T05:40:57.732108Z","caller":"traceutil/trace.go:171","msg":"trace[1638293138] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:13686; }","duration":"129.545055ms","start":"2026-05-09T05:40:57.602543Z","end":"2026-05-09T05:40:57.732088Z","steps":["trace[1638293138] 'agreement among raft nodes before linearized reading'  (duration: 129.324679ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T05:40:57.732098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.334495ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/openvswitch-mjwfn\" ","response":"range_response_count:1 size:12360"}
{"level":"info","ts":"2026-05-09T05:40:57.732194Z","caller":"traceutil/trace.go:171","msg":"trace[1424569356] range","detail":"{range_begin:/registry/pods/openstack/openvswitch-mjwfn; range_end:; response_count:1; response_revision:13686; }","duration":"175.479879ms","start":"2026-05-09T05:40:57.556689Z","end":"2026-05-09T05:40:57.732169Z","steps":["trace[1424569356] 'agreement among raft nodes before linearized reading'  (duration: 175.166591ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T05:40:57.863028Z","caller":"traceutil/trace.go:171","msg":"trace[293136144] transaction","detail":"{read_only:false; response_revision:13688; number_of_response:1; }","duration":"121.437896ms","start":"2026-05-09T05:40:57.741557Z","end":"2026-05-09T05:40:57.862995Z","steps":["trace[293136144] 'process raft request'  (duration: 121.245381ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T05:41:19.720228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.443478ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-83f444ad-51f4-4faf-be73-a15605be2609\" ","response":"range_response_count:1 size:3636"}
{"level":"info","ts":"2026-05-09T05:41:19.720397Z","caller":"traceutil/trace.go:171","msg":"trace[938906027] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-83f444ad-51f4-4faf-be73-a15605be2609; range_end:; response_count:1; response_revision:13996; }","duration":"185.690974ms","start":"2026-05-09T05:41:19.53467Z","end":"2026-05-09T05:41:19.720361Z","steps":["trace[938906027] 'range keys from in-memory index tree'  (duration: 185.18029ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T05:42:45.649615Z","caller":"traceutil/trace.go:171","msg":"trace[434077024] transaction","detail":"{read_only:false; response_revision:14805; number_of_response:1; }","duration":"103.87256ms","start":"2026-05-09T05:42:45.545286Z","end":"2026-05-09T05:42:45.649159Z","steps":["trace[434077024] 'process raft request'  (duration: 103.734546ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T05:42:45.989947Z","caller":"traceutil/trace.go:171","msg":"trace[1642863414] transaction","detail":"{read_only:false; response_revision:14806; number_of_response:1; }","duration":"335.046536ms","start":"2026-05-09T05:42:45.654858Z","end":"2026-05-09T05:42:45.989905Z","steps":["trace[1642863414] 'process raft request'  (duration: 334.801469ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T05:42:45.990199Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T05:42:45.654834Z","time spent":"335.236511ms","remote":"127.0.0.1:58736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:14796 > 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-05-09T05:42:46.307355Z","caller":"traceutil/trace.go:171","msg":"trace[1404269309] linearizableReadLoop","detail":"{readStateIndex:15314; appliedIndex:15311; }","duration":"515.094395ms","start":"2026-05-09T05:42:45.792226Z","end":"2026-05-09T05:42:46.307321Z","steps":["trace[1404269309] 'read index received'  (duration: 197.458061ms)","trace[1404269309] 'applied index is now lower than readState.Index'  (duration: 317.635204ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T05:42:46.307372Z","caller":"traceutil/trace.go:171","msg":"trace[933099180] transaction","detail":"{read_only:false; response_revision:14807; number_of_response:1; }","duration":"650.380489ms","start":"2026-05-09T05:42:45.656925Z","end":"2026-05-09T05:42:46.307305Z","steps":["trace[933099180] 'process raft request'  (duration: 624.825224ms)","trace[933099180] 'compare'  (duration: 25.215755ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T05:42:46.307386Z","caller":"traceutil/trace.go:171","msg":"trace[664666707] transaction","detail":"{read_only:false; response_revision:14808; number_of_response:1; }","duration":"650.214233ms","start":"2026-05-09T05:42:45.657133Z","end":"2026-05-09T05:42:46.307347Z","steps":["trace[664666707] 'process raft request'  (duration: 650.090189ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T05:42:46.307554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"479.031726ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-09T05:42:46.3076Z","caller":"traceutil/trace.go:171","msg":"trace[1950556349] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:14808; }","duration":"479.154328ms","start":"2026-05-09T05:42:45.828435Z","end":"2026-05-09T05:42:46.307589Z","steps":["trace[1950556349] 'agreement among raft nodes before linearized reading'  (duration: 479.057636ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T05:42:46.307603Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T05:42:45.657123Z","time spent":"650.374928ms","remote":"127.0.0.1:58736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:14797 > 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-05-09T05:42:46.307636Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T05:42:45.828408Z","time spent":"479.22101ms","remote":"127.0.0.1:58488","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-05-09T05:42:46.307729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.943051ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:668"}
{"level":"warn","ts":"2026-05-09T05:42:46.307763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"515.520796ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-vwjbp\" ","response":"range_response_count:1 size:22128"}
{"level":"info","ts":"2026-05-09T05:42:46.307813Z","caller":"traceutil/trace.go:171","msg":"trace[32606139] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:14808; }","duration":"150.091456ms","start":"2026-05-09T05:42:46.157702Z","end":"2026-05-09T05:42:46.307793Z","steps":["trace[32606139] 'agreement among raft nodes before linearized reading'  (duration: 149.822479ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T05:42:46.30784Z","caller":"traceutil/trace.go:171","msg":"trace[1592453922] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-vwjbp; range_end:; response_count:1; response_revision:14808; }","duration":"515.667471ms","start":"2026-05-09T05:42:45.792153Z","end":"2026-05-09T05:42:46.307821Z","steps":["trace[1592453922] 'agreement among raft nodes before linearized reading'  (duration: 515.327091ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T05:42:46.307918Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T05:42:45.792126Z","time spent":"515.778013ms","remote":"127.0.0.1:58672","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":22152,"request content":"key:\"/registry/pods/openstack/nova-compute-default-vwjbp\" "}
{"level":"warn","ts":"2026-05-09T05:42:46.307913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"457.110911ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5523"}
{"level":"warn","ts":"2026-05-09T05:42:46.307985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"460.172554ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:668"}
{"level":"info","ts":"2026-05-09T05:42:46.308023Z","caller":"traceutil/trace.go:171","msg":"trace[1618547424] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:14808; }","duration":"460.269476ms","start":"2026-05-09T05:42:45.847744Z","end":"2026-05-09T05:42:46.308013Z","steps":["trace[1618547424] 'agreement among raft nodes before linearized reading'  (duration: 460.148132ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T05:42:46.308031Z","caller":"traceutil/trace.go:171","msg":"trace[78400997] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:14808; }","duration":"457.281015ms","start":"2026-05-09T05:42:45.850722Z","end":"2026-05-09T05:42:46.308003Z","steps":["trace[78400997] 'agreement among raft nodes before linearized reading'  (duration: 456.868454ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T05:42:46.30787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"457.949504ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-05-09T05:42:46.308082Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T05:42:45.850705Z","time spent":"457.368367ms","remote":"127.0.0.1:58716","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":5547,"request content":"key:\"/registry/jobs/openstack/nova-db-sync\" "}
{"level":"warn","ts":"2026-05-09T05:42:46.308212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"438.004492ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"}
{"level":"warn","ts":"2026-05-09T05:42:46.308185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"479.55845ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-vwjbp\" ","response":"range_response_count:1 size:22128"}
{"level":"warn","ts":"2026-05-09T05:42:46.308228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"437.688793ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rook-ceph-pdbstatemap\" ","response":"range_response_count:1 size:356"}
{"level":"info","ts":"2026-05-09T05:42:46.308245Z","caller":"traceutil/trace.go:171","msg":"trace[839042928] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:14808; }","duration":"438.063523ms","start":"2026-05-09T05:42:45.870172Z","end":"2026-05-09T05:42:46.308236Z","steps":["trace[839042928] 'agreement among raft nodes before linearized reading'  (duration: 437.96223ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T05:42:46.308214Z","caller":"traceutil/trace.go:171","msg":"trace[158656061] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:14808; }","duration":"458.238742ms","start":"2026-05-09T05:42:45.849884Z","end":"2026-05-09T05:42:46.308123Z","steps":["trace[158656061] 'agreement among raft nodes before linearized reading'  (duration: 457.953724ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T05:42:46.308282Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T05:42:45.870155Z","time spent":"438.120705ms","remote":"127.0.0.1:58672","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12239,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "}
{"level":"info","ts":"2026-05-09T05:42:46.308284Z","caller":"traceutil/trace.go:171","msg":"trace[503548046] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-vwjbp; range_end:; response_count:1; response_revision:14808; }","duration":"479.659452ms","start":"2026-05-09T05:42:45.828595Z","end":"2026-05-09T05:42:46.308255Z","steps":["trace[503548046] 'agreement among raft nodes before linearized reading'  (duration: 479.370794ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T05:42:46.308051Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T05:42:45.847718Z","time spent":"460.327288ms","remote":"127.0.0.1:58660","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":692,"request content":"key:\"/registry/services/endpoints/openstack/nova-api\" "}
{"level":"info","ts":"2026-05-09T05:42:46.308343Z","caller":"traceutil/trace.go:171","msg":"trace[1098400814] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-pdbstatemap; range_end:; response_count:1; response_revision:14808; }","duration":"437.776406ms","start":"2026-05-09T05:42:45.870498Z","end":"2026-05-09T05:42:46.308274Z","steps":["trace[1098400814] 'agreement among raft nodes before linearized reading'  (duration: 437.604351ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T05:42:46.308379Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T05:42:45.870485Z","time spent":"437.886038ms","remote":"127.0.0.1:58586","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":380,"request content":"key:\"/registry/configmaps/openstack/rook-ceph-pdbstatemap\" "}
{"level":"warn","ts":"2026-05-09T05:42:46.308375Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T05:42:45.828408Z","time spent":"479.95365ms","remote":"127.0.0.1:58672","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":22152,"request content":"key:\"/registry/pods/openstack/nova-compute-default-vwjbp\" "}
{"level":"warn","ts":"2026-05-09T05:42:46.308413Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T05:42:45.84987Z","time spent":"458.474368ms","remote":"127.0.0.1:58716","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":0,"response size":29,"request content":"key:\"/registry/jobs/openstack/nova-rabbit-init\" "}
{"level":"warn","ts":"2026-05-09T05:42:46.30827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.799188ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-k7g5p\" ","response":"range_response_count:1 size:6527"}
{"level":"info","ts":"2026-05-09T05:42:46.308533Z","caller":"traceutil/trace.go:171","msg":"trace[900901333] range","detail":"{range_begin:/registry/pods/openstack/keepalived-k7g5p; range_end:; response_count:1; response_revision:14808; }","duration":"146.120277ms","start":"2026-05-09T05:42:46.162394Z","end":"2026-05-09T05:42:46.308514Z","steps":["trace[900901333] 'agreement among raft nodes before linearized reading'  (duration: 145.675855ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T05:42:46.313298Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T05:42:45.656897Z","time spent":"650.595295ms","remote":"127.0.0.1:58736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:14795 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-05-09T05:44:11.751729Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":13017}
{"level":"info","ts":"2026-05-09T05:44:11.824967Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":13017,"took":"70.381501ms","hash":2002286146,"current-db-size-bytes":59125760,"current-db-size":"59 MB","current-db-size-in-use-bytes":30449664,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-05-09T05:44:11.82503Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2002286146,"revision":13017,"compact-revision":10981}
{"level":"warn","ts":"2026-05-09T05:48:27.782241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.043041ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/libvirt-libvirt-default-9m99r\" ","response":"range_response_count:1 size:20867"}
{"level":"info","ts":"2026-05-09T05:48:27.782327Z","caller":"traceutil/trace.go:171","msg":"trace[1912380319] range","detail":"{range_begin:/registry/pods/openstack/libvirt-libvirt-default-9m99r; range_end:; response_count:1; response_revision:17355; }","duration":"124.195635ms","start":"2026-05-09T05:48:27.658111Z","end":"2026-05-09T05:48:27.782307Z","steps":["trace[1912380319] 'range keys from in-memory index tree'  (duration: 123.881347ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T05:48:28.310388Z","caller":"traceutil/trace.go:171","msg":"trace[807368946] linearizableReadLoop","detail":"{readStateIndex:17946; appliedIndex:17945; }","duration":"482.486042ms","start":"2026-05-09T05:48:27.827863Z","end":"2026-05-09T05:48:28.310349Z","steps":["trace[807368946] 'read index received'  (duration: 482.075301ms)","trace[807368946] 'applied index is now lower than readState.Index'  (duration: 409.011µs)"],"step_count":2}
{"level":"info","ts":"2026-05-09T05:48:28.310551Z","caller":"traceutil/trace.go:171","msg":"trace[562587927] transaction","detail":"{read_only:false; response_revision:17357; number_of_response:1; }","duration":"511.038368ms","start":"2026-05-09T05:48:27.799459Z","end":"2026-05-09T05:48:28.310497Z","steps":["trace[562587927] 'process raft request'  (duration: 510.649427ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T05:48:28.310683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"482.793629ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"warn","ts":"2026-05-09T05:48:28.310762Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T05:48:27.799421Z","time spent":"511.230353ms","remote":"127.0.0.1:58672","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":20982,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/pods/openstack/libvirt-libvirt-default-9m99r\" mod_revision:17282 > success:<request_put:<key:\"/registry/pods/openstack/libvirt-libvirt-default-9m99r\" value_size:20918 >> failure:<request_range:<key:\"/registry/pods/openstack/libvirt-libvirt-default-9m99r\" > >"}
{"level":"info","ts":"2026-05-09T05:48:28.310782Z","caller":"traceutil/trace.go:171","msg":"trace[1478807851] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:17357; }","duration":"482.943174ms","start":"2026-05-09T05:48:27.827816Z","end":"2026-05-09T05:48:28.310759Z","steps":["trace[1478807851] 'agreement among raft nodes before linearized reading'  (duration: 482.761189ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T05:48:28.310832Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T05:48:27.827802Z","time spent":"483.019486ms","remote":"127.0.0.1:58746","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":4,"response size":32,"request content":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true "}
{"level":"warn","ts":"2026-05-09T05:48:28.310892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.351297ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"info","ts":"2026-05-09T05:48:28.310957Z","caller":"traceutil/trace.go:171","msg":"trace[2016036926] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:17357; }","duration":"167.442869ms","start":"2026-05-09T05:48:28.143498Z","end":"2026-05-09T05:48:28.31094Z","steps":["trace[2016036926] 'agreement among raft nodes before linearized reading'  (duration: 167.245374ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T05:48:28.310945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.131377ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:561"}
{"level":"info","ts":"2026-05-09T05:48:28.31103Z","caller":"traceutil/trace.go:171","msg":"trace[207928919] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:17357; }","duration":"137.27935ms","start":"2026-05-09T05:48:28.173726Z","end":"2026-05-09T05:48:28.311006Z","steps":["trace[207928919] 'agreement among raft nodes before linearized reading'  (duration: 137.067315ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T05:48:28.311155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.599563ms","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-05-09T05:48:28.311282Z","caller":"traceutil/trace.go:171","msg":"trace[2139432593] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:17357; }","duration":"167.777079ms","start":"2026-05-09T05:48:28.143482Z","end":"2026-05-09T05:48:28.311259Z","steps":["trace[2139432593] 'agreement among raft nodes before linearized reading'  (duration: 167.256395ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T05:48:28.311391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"358.204154ms","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-05-09T05:48:28.311409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"482.528453ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-09T05:48:28.311505Z","caller":"traceutil/trace.go:171","msg":"trace[39252847] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:17357; }","duration":"358.314608ms","start":"2026-05-09T05:48:27.953122Z","end":"2026-05-09T05:48:28.311437Z","steps":["trace[39252847] 'agreement among raft nodes before linearized reading'  (duration: 358.169003ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T05:48:28.311557Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T05:48:27.953106Z","time spent":"358.439751ms","remote":"127.0.0.1:58736","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":582,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"info","ts":"2026-05-09T05:48:28.31157Z","caller":"traceutil/trace.go:171","msg":"trace[1054412996] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:17357; }","duration":"482.770471ms","start":"2026-05-09T05:48:27.828771Z","end":"2026-05-09T05:48:28.311541Z","steps":["trace[1054412996] 'agreement among raft nodes before linearized reading'  (duration: 481.933847ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T05:48:28.311757Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T05:48:27.828763Z","time spent":"482.979046ms","remote":"127.0.0.1:58488","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":30,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-05-09T05:49:11.758046Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15375}
{"level":"info","ts":"2026-05-09T05:49:11.857595Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15375,"took":"94.007655ms","hash":2619340818,"current-db-size-bytes":59125760,"current-db-size":"59 MB","current-db-size-in-use-bytes":32976896,"current-db-size-in-use":"33 MB"}
{"level":"info","ts":"2026-05-09T05:49:11.857677Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2619340818,"revision":15375,"compact-revision":13017}
{"level":"info","ts":"2026-05-09T05:52:27.921585Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"c3b8446219deb8c1","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-05-09T05:52:27.927895Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002}
{"level":"info","ts":"2026-05-09T05:52:27.928001Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002}
{"level":"info","ts":"2026-05-09T05:54:03.070289Z","caller":"traceutil/trace.go:171","msg":"trace[1912608813] transaction","detail":"{read_only:false; response_revision:19970; number_of_response:1; }","duration":"174.044051ms","start":"2026-05-09T05:54:02.896216Z","end":"2026-05-09T05:54:03.07026Z","steps":["trace[1912608813] 'process raft request'  (duration: 173.865786ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T05:54:03.369138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.994259ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13313095744241993936 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:19962 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:476 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-09T05:54:03.369323Z","caller":"traceutil/trace.go:171","msg":"trace[1547193509] linearizableReadLoop","detail":"{readStateIndex:20648; appliedIndex:20647; }","duration":"121.905314ms","start":"2026-05-09T05:54:03.247348Z","end":"2026-05-09T05:54:03.369254Z","steps":["trace[1547193509] 'read index received'  (duration: 35.111µs)","trace[1547193509] 'applied index is now lower than readState.Index'  (duration: 121.868413ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T05:54:03.369553Z","caller":"traceutil/trace.go:171","msg":"trace[862676259] transaction","detail":"{read_only:false; response_revision:19971; number_of_response:1; }","duration":"173.236129ms","start":"2026-05-09T05:54:03.196298Z","end":"2026-05-09T05:54:03.369534Z","steps":["trace[862676259] 'process raft request'  (duration: 33.717946ms)","trace[862676259] 'compare'  (duration: 138.627669ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T05:54:03.369779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.992234ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"}
{"level":"warn","ts":"2026-05-09T05:54:03.369808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.445629ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"}
{"level":"info","ts":"2026-05-09T05:54:03.369872Z","caller":"traceutil/trace.go:171","msg":"trace[547678659] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:19971; }","duration":"105.132838ms","start":"2026-05-09T05:54:03.264713Z","end":"2026-05-09T05:54:03.369846Z","steps":["trace[547678659] 'agreement among raft nodes before linearized reading'  (duration: 104.886901ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T05:54:03.369896Z","caller":"traceutil/trace.go:171","msg":"trace[1986557467] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:19971; }","duration":"122.596272ms","start":"2026-05-09T05:54:03.247282Z","end":"2026-05-09T05:54:03.369879Z","steps":["trace[1986557467] 'agreement among raft nodes before linearized reading'  (duration: 122.313175ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T05:54:03.654294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.425296ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13313095744241993940 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:19964 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-09T05:54:03.654466Z","caller":"traceutil/trace.go:171","msg":"trace[169831594] transaction","detail":"{read_only:false; response_revision:19973; number_of_response:1; }","duration":"277.40511ms","start":"2026-05-09T05:54:03.377001Z","end":"2026-05-09T05:54:03.654407Z","steps":["trace[169831594] 'process raft request'  (duration: 132.738328ms)","trace[169831594] 'compare'  (duration: 144.284132ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T05:54:04.106698Z","caller":"traceutil/trace.go:171","msg":"trace[2020002719] transaction","detail":"{read_only:false; response_revision:19976; number_of_response:1; }","duration":"167.835882ms","start":"2026-05-09T05:54:03.938828Z","end":"2026-05-09T05:54:04.106663Z","steps":["trace[2020002719] 'process raft request'  (duration: 159.533576ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T05:54:04.379651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.352584ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:557"}
{"level":"info","ts":"2026-05-09T05:54:04.379766Z","caller":"traceutil/trace.go:171","msg":"trace[1901429284] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:19977; }","duration":"123.520049ms","start":"2026-05-09T05:54:04.256219Z","end":"2026-05-09T05:54:04.379739Z","steps":["trace[1901429284] 'range keys from in-memory index tree'  (duration: 123.139088ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T05:54:04.379949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.555868ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"warn","ts":"2026-05-09T05:54:04.379941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.469225ms","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-05-09T05:54:04.38003Z","caller":"traceutil/trace.go:171","msg":"trace[66321046] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:19977; }","duration":"127.703332ms","start":"2026-05-09T05:54:04.252305Z","end":"2026-05-09T05:54:04.380009Z","steps":["trace[66321046] 'range keys from in-memory index tree'  (duration: 127.341462ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T05:54:04.380049Z","caller":"traceutil/trace.go:171","msg":"trace[243730523] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:19977; }","duration":"127.635301ms","start":"2026-05-09T05:54:04.252389Z","end":"2026-05-09T05:54:04.380025Z","steps":["trace[243730523] 'range keys from in-memory index tree'  (duration: 127.23938ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T05:54:04.551573Z","caller":"traceutil/trace.go:171","msg":"trace[1247541818] transaction","detail":"{read_only:false; response_revision:19979; number_of_response:1; }","duration":"166.129676ms","start":"2026-05-09T05:54:04.3854Z","end":"2026-05-09T05:54:04.551529Z","steps":["trace[1247541818] 'process raft request'  (duration: 147.023056ms)","trace[1247541818] 'compare'  (duration: 18.399061ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T05:54:04.55164Z","caller":"traceutil/trace.go:171","msg":"trace[1731917604] linearizableReadLoop","detail":"{readStateIndex:20657; appliedIndex:20655; }","duration":"131.136585ms","start":"2026-05-09T05:54:04.420446Z","end":"2026-05-09T05:54:04.551583Z","steps":["trace[1731917604] 'read index received'  (duration: 111.992524ms)","trace[1731917604] 'applied index is now lower than readState.Index'  (duration: 19.142301ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T05:54:04.551745Z","caller":"traceutil/trace.go:171","msg":"trace[1536184450] transaction","detail":"{read_only:false; response_revision:19980; number_of_response:1; }","duration":"165.943161ms","start":"2026-05-09T05:54:04.385743Z","end":"2026-05-09T05:54:04.551687Z","steps":["trace[1536184450] 'process raft request'  (duration: 165.641643ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T05:54:04.551881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.407533ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rook-ceph-pdbstatemap\" ","response":"range_response_count:1 size:357"}
{"level":"info","ts":"2026-05-09T05:54:04.551953Z","caller":"traceutil/trace.go:171","msg":"trace[2019123773] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-pdbstatemap; range_end:; response_count:1; response_revision:19980; }","duration":"131.507266ms","start":"2026-05-09T05:54:04.420427Z","end":"2026-05-09T05:54:04.551935Z","steps":["trace[2019123773] 'agreement among raft nodes before linearized reading'  (duration: 131.330471ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T05:54:11.764425Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17915}
{"level":"info","ts":"2026-05-09T05:54:11.892827Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17915,"took":"123.927278ms","hash":1869531769,"current-db-size-bytes":59125760,"current-db-size":"59 MB","current-db-size-in-use-bytes":29675520,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-05-09T05:54:11.892912Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1869531769,"revision":17915,"compact-revision":15375}
{"level":"info","ts":"2026-05-09T05:57:57.941558Z","caller":"traceutil/trace.go:171","msg":"trace[1056081518] linearizableReadLoop","detail":"{readStateIndex:23147; appliedIndex:23146; }","duration":"165.517803ms","start":"2026-05-09T05:57:57.776009Z","end":"2026-05-09T05:57:57.941527Z","steps":["trace[1056081518] 'read index received'  (duration: 165.299187ms)","trace[1056081518] 'applied index is now lower than readState.Index'  (duration: 217.226µs)"],"step_count":2}
{"level":"info","ts":"2026-05-09T05:57:57.94165Z","caller":"traceutil/trace.go:171","msg":"trace[308563409] transaction","detail":"{read_only:false; response_revision:22394; number_of_response:1; }","duration":"201.417574ms","start":"2026-05-09T05:57:57.740197Z","end":"2026-05-09T05:57:57.941614Z","steps":["trace[308563409] 'process raft request'  (duration: 201.121096ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T05:57:57.941931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.876073ms","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-05-09T05:57:57.942066Z","caller":"traceutil/trace.go:171","msg":"trace[645526382] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:22394; }","duration":"166.080218ms","start":"2026-05-09T05:57:57.775955Z","end":"2026-05-09T05:57:57.942035Z","steps":["trace[645526382] 'agreement among raft nodes before linearized reading'  (duration: 165.700018ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T05:57:58.079949Z","caller":"traceutil/trace.go:171","msg":"trace[1389229783] linearizableReadLoop","detail":"{readStateIndex:23148; appliedIndex:23147; }","duration":"138.207555ms","start":"2026-05-09T05:57:57.941722Z","end":"2026-05-09T05:57:58.079929Z","steps":["trace[1389229783] 'read index received'  (duration: 114.167536ms)","trace[1389229783] 'applied index is now lower than readState.Index'  (duration: 24.038769ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T05:57:58.080093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.565222ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-09T05:57:58.080122Z","caller":"traceutil/trace.go:171","msg":"trace[641165292] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:22395; }","duration":"250.617483ms","start":"2026-05-09T05:57:57.829496Z","end":"2026-05-09T05:57:58.080114Z","steps":["trace[641165292] 'agreement among raft nodes before linearized reading'  (duration: 250.510911ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T05:57:58.080173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.77808ms","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-05-09T05:57:58.080252Z","caller":"traceutil/trace.go:171","msg":"trace[1138304674] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:22395; }","duration":"192.871233ms","start":"2026-05-09T05:57:57.887364Z","end":"2026-05-09T05:57:58.080235Z","steps":["trace[1138304674] 'agreement among raft nodes before linearized reading'  (duration: 192.611116ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T05:57:58.080207Z","caller":"traceutil/trace.go:171","msg":"trace[1255358835] transaction","detail":"{read_only:false; response_revision:22395; number_of_response:1; }","duration":"199.562954ms","start":"2026-05-09T05:57:57.88053Z","end":"2026-05-09T05:57:58.080093Z","steps":["trace[1255358835] 'process raft request'  (duration: 175.254817ms)","trace[1255358835] 'compare'  (duration: 23.256708ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T05:57:58.080385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.125192ms","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-05-09T05:57:58.080496Z","caller":"traceutil/trace.go:171","msg":"trace[1252475836] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:22395; }","duration":"202.297287ms","start":"2026-05-09T05:57:57.878175Z","end":"2026-05-09T05:57:58.080472Z","steps":["trace[1252475836] 'agreement among raft nodes before linearized reading'  (duration: 201.956398ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T05:57:58.080656Z","caller":"traceutil/trace.go:171","msg":"trace[1598226066] transaction","detail":"{read_only:false; response_revision:22396; number_of_response:1; }","duration":"133.592221ms","start":"2026-05-09T05:57:57.947027Z","end":"2026-05-09T05:57:58.080619Z","steps":["trace[1598226066] 'process raft request'  (duration: 133.345594ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T05:57:58.080758Z","caller":"traceutil/trace.go:171","msg":"trace[362829882] transaction","detail":"{read_only:false; response_revision:22397; number_of_response:1; }","duration":"111.983526ms","start":"2026-05-09T05:57:57.968757Z","end":"2026-05-09T05:57:58.080741Z","steps":["trace[362829882] 'process raft request'  (duration: 111.808151ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T05:59:11.770141Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":20016}
{"level":"info","ts":"2026-05-09T05:59:11.877321Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":20016,"took":"102.428412ms","hash":88774926,"current-db-size-bytes":59125760,"current-db-size":"59 MB","current-db-size-in-use-bytes":40861696,"current-db-size-in-use":"41 MB"}
{"level":"info","ts":"2026-05-09T05:59:11.877554Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":88774926,"revision":20016,"compact-revision":17915}
{"level":"info","ts":"2026-05-09T06:01:36.285889Z","caller":"traceutil/trace.go:171","msg":"trace[1808996537] linearizableReadLoop","detail":"{readStateIndex:25474; appliedIndex:25473; }","duration":"110.48178ms","start":"2026-05-09T06:01:36.175378Z","end":"2026-05-09T06:01:36.28586Z","steps":["trace[1808996537] 'read index received'  (duration: 110.248814ms)","trace[1808996537] 'applied index is now lower than readState.Index'  (duration: 231.846µs)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T06:01:36.286181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.775369ms","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-05-09T06:01:36.286213Z","caller":"traceutil/trace.go:171","msg":"trace[321523134] transaction","detail":"{read_only:false; response_revision:24666; number_of_response:1; }","duration":"285.291197ms","start":"2026-05-09T06:01:36.000892Z","end":"2026-05-09T06:01:36.286184Z","steps":["trace[321523134] 'process raft request'  (duration: 284.763473ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T06:01:36.286264Z","caller":"traceutil/trace.go:171","msg":"trace[810763714] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24666; }","duration":"110.879122ms","start":"2026-05-09T06:01:36.17536Z","end":"2026-05-09T06:01:36.286239Z","steps":["trace[810763714] 'agreement among raft nodes before linearized reading'  (duration: 110.623305ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T06:01:36.476897Z","caller":"traceutil/trace.go:171","msg":"trace[324724181] transaction","detail":"{read_only:false; response_revision:24667; number_of_response:1; }","duration":"185.547148ms","start":"2026-05-09T06:01:36.291308Z","end":"2026-05-09T06:01:36.476855Z","steps":["trace[324724181] 'process raft request'  (duration: 128.917251ms)","trace[324724181] 'compare'  (duration: 56.445302ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T06:01:40.581983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.746518ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13313095744242006483 > lease_revoke:<id:38c19e0b284f3817>","response":"size:30"}
{"level":"info","ts":"2026-05-09T06:01:41.173213Z","caller":"traceutil/trace.go:171","msg":"trace[1296412571] linearizableReadLoop","detail":"{readStateIndex:25506; appliedIndex:25505; }","duration":"144.0252ms","start":"2026-05-09T06:01:41.029153Z","end":"2026-05-09T06:01:41.173178Z","steps":["trace[1296412571] 'read index received'  (duration: 140.155686ms)","trace[1296412571] 'applied index is now lower than readState.Index'  (duration: 3.856774ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T06:01:41.173566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.384391ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:18367"}
{"level":"info","ts":"2026-05-09T06:01:41.17361Z","caller":"traceutil/trace.go:171","msg":"trace[1633518868] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:24697; }","duration":"144.492915ms","start":"2026-05-09T06:01:41.029106Z","end":"2026-05-09T06:01:41.173598Z","steps":["trace[1633518868] 'agreement among raft nodes before linearized reading'  (duration: 144.212696ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T06:01:41.173604Z","caller":"traceutil/trace.go:171","msg":"trace[1617231669] transaction","detail":"{read_only:false; response_revision:24697; number_of_response:1; }","duration":"195.367555ms","start":"2026-05-09T06:01:40.978078Z","end":"2026-05-09T06:01:41.173446Z","steps":["trace[1617231669] 'process raft request'  (duration: 191.234163ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T06:01:41.564269Z","caller":"traceutil/trace.go:171","msg":"trace[88138543] linearizableReadLoop","detail":"{readStateIndex:25507; appliedIndex:25506; }","duration":"202.168129ms","start":"2026-05-09T06:01:41.362061Z","end":"2026-05-09T06:01:41.564229Z","steps":["trace[88138543] 'read index received'  (duration: 201.869691ms)","trace[88138543] 'applied index is now lower than readState.Index'  (duration: 296.698µs)"],"step_count":2}
{"level":"info","ts":"2026-05-09T06:01:41.564377Z","caller":"traceutil/trace.go:171","msg":"trace[1678249635] transaction","detail":"{read_only:false; response_revision:24698; number_of_response:1; }","duration":"309.667179ms","start":"2026-05-09T06:01:41.254668Z","end":"2026-05-09T06:01:41.564335Z","steps":["trace[1678249635] 'process raft request'  (duration: 309.33374ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T06:01:41.56457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.473628ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"}
{"level":"warn","ts":"2026-05-09T06:01:41.564584Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T06:01:41.254648Z","time spent":"309.817063ms","remote":"127.0.0.1:58736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":554,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:24685 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:476 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"info","ts":"2026-05-09T06:01:41.564625Z","caller":"traceutil/trace.go:171","msg":"trace[151716862] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24698; }","duration":"202.58245ms","start":"2026-05-09T06:01:41.362025Z","end":"2026-05-09T06:01:41.564607Z","steps":["trace[151716862] 'agreement among raft nodes before linearized reading'  (duration: 202.374495ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T06:01:41.722833Z","caller":"traceutil/trace.go:171","msg":"trace[403986559] transaction","detail":"{read_only:false; response_revision:24699; number_of_response:1; }","duration":"326.971388ms","start":"2026-05-09T06:01:41.395788Z","end":"2026-05-09T06:01:41.722759Z","steps":["trace[403986559] 'process raft request'  (duration: 277.019322ms)","trace[403986559] 'compare'  (duration: 49.594816ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T06:01:41.722908Z","caller":"traceutil/trace.go:171","msg":"trace[1367354177] transaction","detail":"{read_only:false; response_revision:24700; number_of_response:1; }","duration":"153.125728ms","start":"2026-05-09T06:01:41.569756Z","end":"2026-05-09T06:01:41.722882Z","steps":["trace[1367354177] 'process raft request'  (duration: 152.980734ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T06:01:41.722894Z","caller":"traceutil/trace.go:171","msg":"trace[593279624] linearizableReadLoop","detail":"{readStateIndex:25508; appliedIndex:25507; }","duration":"158.486264ms","start":"2026-05-09T06:01:41.564363Z","end":"2026-05-09T06:01:41.722849Z","steps":["trace[593279624] 'read index received'  (duration: 108.457765ms)","trace[593279624] 'applied index is now lower than readState.Index'  (duration: 50.023419ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T06:01:41.723077Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T06:01:41.395775Z","time spent":"327.159674ms","remote":"127.0.0.1:58736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/capi-system/controller-leader-election-capi\" mod_revision:24689 > success:<request_put:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" > >"}
{"level":"warn","ts":"2026-05-09T06:01:41.723165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.623205ms","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-05-09T06:01:41.723251Z","caller":"traceutil/trace.go:171","msg":"trace[1658188419] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:24700; }","duration":"345.80967ms","start":"2026-05-09T06:01:41.377419Z","end":"2026-05-09T06:01:41.723229Z","steps":["trace[1658188419] 'agreement among raft nodes before linearized reading'  (duration: 345.582274ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T06:01:41.723268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.67543ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"}
{"level":"warn","ts":"2026-05-09T06:01:41.723294Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T06:01:41.377389Z","time spent":"345.896743ms","remote":"127.0.0.1:58736","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":582,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"info","ts":"2026-05-09T06:01:41.723307Z","caller":"traceutil/trace.go:171","msg":"trace[1469876593] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24700; }","duration":"347.731012ms","start":"2026-05-09T06:01:41.375564Z","end":"2026-05-09T06:01:41.723295Z","steps":["trace[1469876593] 'agreement among raft nodes before linearized reading'  (duration: 347.515736ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T06:01:41.723341Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T06:01:41.37556Z","time spent":"347.773783ms","remote":"127.0.0.1:58736","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-05-09T06:01:41.723339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.965449ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"}
{"level":"info","ts":"2026-05-09T06:01:41.723449Z","caller":"traceutil/trace.go:171","msg":"trace[261456663] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24700; }","duration":"102.120624ms","start":"2026-05-09T06:01:41.621287Z","end":"2026-05-09T06:01:41.723408Z","steps":["trace[261456663] 'agreement among raft nodes before linearized reading'  (duration: 101.827186ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T06:01:41.83771Z","caller":"traceutil/trace.go:171","msg":"trace[1516418601] transaction","detail":"{read_only:false; response_revision:24701; number_of_response:1; }","duration":"109.048061ms","start":"2026-05-09T06:01:41.72864Z","end":"2026-05-09T06:01:41.837688Z","steps":["trace[1516418601] 'process raft request'  (duration: 101.738442ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T06:01:41.994625Z","caller":"traceutil/trace.go:171","msg":"trace[1110904878] transaction","detail":"{read_only:false; response_revision:24704; number_of_response:1; }","duration":"211.238457ms","start":"2026-05-09T06:01:41.783361Z","end":"2026-05-09T06:01:41.994599Z","steps":["trace[1110904878] 'process raft request'  (duration: 211.186076ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T06:01:41.995051Z","caller":"traceutil/trace.go:171","msg":"trace[418641452] transaction","detail":"{read_only:false; response_revision:24702; number_of_response:1; }","duration":"265.997723ms","start":"2026-05-09T06:01:41.729042Z","end":"2026-05-09T06:01:41.995039Z","steps":["trace[418641452] 'process raft request'  (duration: 265.294844ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T06:01:41.995195Z","caller":"traceutil/trace.go:171","msg":"trace[300924905] transaction","detail":"{read_only:false; response_revision:24703; number_of_response:1; }","duration":"265.770537ms","start":"2026-05-09T06:01:41.729414Z","end":"2026-05-09T06:01:41.995184Z","steps":["trace[300924905] 'process raft request'  (duration: 265.082378ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T06:01:42.004728Z","caller":"traceutil/trace.go:171","msg":"trace[1339966753] transaction","detail":"{read_only:false; response_revision:24705; number_of_response:1; }","duration":"106.157633ms","start":"2026-05-09T06:01:41.898546Z","end":"2026-05-09T06:01:42.004703Z","steps":["trace[1339966753] 'process raft request'  (duration: 106.05116ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T06:01:42.182445Z","caller":"traceutil/trace.go:171","msg":"trace[1589392315] transaction","detail":"{read_only:false; response_revision:24706; number_of_response:1; }","duration":"134.149133ms","start":"2026-05-09T06:01:42.048256Z","end":"2026-05-09T06:01:42.182405Z","steps":["trace[1589392315] 'process raft request'  (duration: 132.787195ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T06:01:42.649641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.782349ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:533"}
{"level":"info","ts":"2026-05-09T06:01:42.649745Z","caller":"traceutil/trace.go:171","msg":"trace[140639750] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:24707; }","duration":"120.954084ms","start":"2026-05-09T06:01:42.528767Z","end":"2026-05-09T06:01:42.649721Z","steps":["trace[140639750] 'range keys from in-memory index tree'  (duration: 120.509712ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T06:01:42.986458Z","caller":"traceutil/trace.go:171","msg":"trace[723647256] linearizableReadLoop","detail":"{readStateIndex:25518; appliedIndex:25516; }","duration":"311.366194ms","start":"2026-05-09T06:01:42.675057Z","end":"2026-05-09T06:01:42.986423Z","steps":["trace[723647256] 'read index received'  (duration: 76.407544ms)","trace[723647256] 'applied index is now lower than readState.Index'  (duration: 234.95708ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T06:01:42.986617Z","caller":"traceutil/trace.go:171","msg":"trace[1716325082] transaction","detail":"{read_only:false; response_revision:24709; number_of_response:1; }","duration":"331.444741ms","start":"2026-05-09T06:01:42.655115Z","end":"2026-05-09T06:01:42.98656Z","steps":["trace[1716325082] 'process raft request'  (duration: 331.097131ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T06:01:42.98672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.623452ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/machinehealthchecks/\" range_end:\"/registry/cluster.x-k8s.io/machinehealthchecks0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-09T06:01:42.986848Z","caller":"traceutil/trace.go:171","msg":"trace[1867095140] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machinehealthchecks/; range_end:/registry/cluster.x-k8s.io/machinehealthchecks0; response_count:0; response_revision:24709; }","duration":"311.775616ms","start":"2026-05-09T06:01:42.675006Z","end":"2026-05-09T06:01:42.986781Z","steps":["trace[1867095140] 'agreement among raft nodes before linearized reading'  (duration: 311.55464ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T06:01:42.986828Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.585729ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-05-09T06:01:42.986898Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T06:01:42.674988Z","time spent":"311.897389ms","remote":"127.0.0.1:41700","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":30,"request content":"key:\"/registry/cluster.x-k8s.io/machinehealthchecks/\" range_end:\"/registry/cluster.x-k8s.io/machinehealthchecks0\" count_only:true "}
{"level":"warn","ts":"2026-05-09T06:01:42.986923Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T06:01:42.65509Z","time spent":"331.667637ms","remote":"127.0.0.1:58736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":515,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/cert-manager/cert-manager-controller\" mod_revision:24593 > success:<request_put:<key:\"/registry/leases/cert-manager/cert-manager-controller\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/cert-manager/cert-manager-controller\" > >"}
{"level":"info","ts":"2026-05-09T06:01:42.98694Z","caller":"traceutil/trace.go:171","msg":"trace[1327583725] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24709; }","duration":"157.759333ms","start":"2026-05-09T06:01:42.829146Z","end":"2026-05-09T06:01:42.986906Z","steps":["trace[1327583725] 'agreement among raft nodes before linearized reading'  (duration: 157.539987ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T06:01:43.294662Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.730195ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13313095744242006521 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:24696 > success:<request_put:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" value_size:441 >> failure:<request_range:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-09T06:01:43.29481Z","caller":"traceutil/trace.go:171","msg":"trace[2050176030] transaction","detail":"{read_only:false; response_revision:24710; number_of_response:1; }","duration":"261.555723ms","start":"2026-05-09T06:01:43.033228Z","end":"2026-05-09T06:01:43.294783Z","steps":["trace[2050176030] 'process raft request'  (duration: 118.572021ms)","trace[2050176030] 'compare'  (duration: 142.406417ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T06:01:43.29708Z","caller":"traceutil/trace.go:171","msg":"trace[1984347743] transaction","detail":"{read_only:false; response_revision:24711; number_of_response:1; }","duration":"117.288575ms","start":"2026-05-09T06:01:43.179763Z","end":"2026-05-09T06:01:43.297052Z","steps":["trace[1984347743] 'process raft request'  (duration: 117.084909ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T06:01:43.878026Z","caller":"traceutil/trace.go:171","msg":"trace[210099705] transaction","detail":"{read_only:false; response_revision:24714; number_of_response:1; }","duration":"144.155295ms","start":"2026-05-09T06:01:43.733838Z","end":"2026-05-09T06:01:43.877993Z","steps":["trace[210099705] 'process raft request'  (duration: 143.492607ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T06:01:43.878383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.137079ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-09T06:01:43.878461Z","caller":"traceutil/trace.go:171","msg":"trace[1555245704] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:24714; }","duration":"100.252012ms","start":"2026-05-09T06:01:43.778166Z","end":"2026-05-09T06:01:43.878418Z","steps":["trace[1555245704] 'agreement among raft nodes before linearized reading'  (duration: 100.127119ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T06:01:44.036838Z","caller":"traceutil/trace.go:171","msg":"trace[788534134] linearizableReadLoop","detail":"{readStateIndex:25525; appliedIndex:25524; }","duration":"140.467075ms","start":"2026-05-09T06:01:43.896343Z","end":"2026-05-09T06:01:44.03681Z","steps":["trace[788534134] 'read index received'  (duration: 94.038334ms)","trace[788534134] 'applied index is now lower than readState.Index'  (duration: 46.427531ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T06:01:44.037029Z","caller":"traceutil/trace.go:171","msg":"trace[338595458] transaction","detail":"{read_only:false; response_revision:24716; number_of_response:1; }","duration":"143.214389ms","start":"2026-05-09T06:01:43.893762Z","end":"2026-05-09T06:01:44.036977Z","steps":["trace[338595458] 'process raft request'  (duration: 96.49163ms)","trace[338595458] 'compare'  (duration: 46.227906ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T06:01:44.037143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.772003ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/magnum-system/\" range_end:\"/registry/endpointslices/magnum-system0\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-09T06:01:44.037177Z","caller":"traceutil/trace.go:171","msg":"trace[513005519] range","detail":"{range_begin:/registry/endpointslices/magnum-system/; range_end:/registry/endpointslices/magnum-system0; response_count:0; response_revision:24716; }","duration":"140.840535ms","start":"2026-05-09T06:01:43.896326Z","end":"2026-05-09T06:01:44.037167Z","steps":["trace[513005519] 'agreement among raft nodes before linearized reading'  (duration: 140.758043ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T06:01:44.074948Z","caller":"traceutil/trace.go:171","msg":"trace[1796499630] transaction","detail":"{read_only:false; response_revision:24717; number_of_response:1; }","duration":"167.700504ms","start":"2026-05-09T06:01:43.907213Z","end":"2026-05-09T06:01:44.074914Z","steps":["trace[1796499630] 'process raft request'  (duration: 167.410676ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T06:01:44.172673Z","caller":"traceutil/trace.go:171","msg":"trace[349890447] transaction","detail":"{read_only:false; response_revision:24718; number_of_response:1; }","duration":"171.894037ms","start":"2026-05-09T06:01:44.000744Z","end":"2026-05-09T06:01:44.172638Z","steps":["trace[349890447] 'process raft request'  (duration: 159.44709ms)","trace[349890447] 'compare'  (duration: 12.235831ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T06:01:44.172874Z","caller":"traceutil/trace.go:171","msg":"trace[361057511] linearizableReadLoop","detail":"{readStateIndex:25528; appliedIndex:25525; }","duration":"135.9154ms","start":"2026-05-09T06:01:44.03691Z","end":"2026-05-09T06:01:44.172825Z","steps":["trace[361057511] 'read index received'  (duration: 37.639022ms)","trace[361057511] 'applied index is now lower than readState.Index'  (duration: 98.275188ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T06:01:44.172934Z","caller":"traceutil/trace.go:171","msg":"trace[355164841] transaction","detail":"{read_only:false; response_revision:24719; number_of_response:1; }","duration":"162.80113ms","start":"2026-05-09T06:01:44.010106Z","end":"2026-05-09T06:01:44.172907Z","steps":["trace[355164841] 'process raft request'  (duration: 162.465851ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T06:01:44.173181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.227185ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:562"}
{"level":"info","ts":"2026-05-09T06:01:44.173222Z","caller":"traceutil/trace.go:171","msg":"trace[190682310] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:24719; }","duration":"169.299076ms","start":"2026-05-09T06:01:44.003909Z","end":"2026-05-09T06:01:44.173208Z","steps":["trace[190682310] 'agreement among raft nodes before linearized reading'  (duration: 169.097901ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T06:01:44.173345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.209228ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/magnum-system/\" range_end:\"/registry/endpointslices/magnum-system0\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-09T06:01:44.173372Z","caller":"traceutil/trace.go:171","msg":"trace[383920845] range","detail":"{range_begin:/registry/endpointslices/magnum-system/; range_end:/registry/endpointslices/magnum-system0; response_count:0; response_revision:24719; }","duration":"129.765043ms","start":"2026-05-09T06:01:44.043597Z","end":"2026-05-09T06:01:44.173362Z","steps":["trace[383920845] 'agreement among raft nodes before linearized reading'  (duration: 129.716862ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T06:01:44.173385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.664996ms","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-05-09T06:01:44.173424Z","caller":"traceutil/trace.go:171","msg":"trace[896877779] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:24719; }","duration":"173.744498ms","start":"2026-05-09T06:01:43.999664Z","end":"2026-05-09T06:01:44.173408Z","steps":["trace[896877779] 'agreement among raft nodes before linearized reading'  (duration: 173.627665ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T06:01:44.173659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.062538ms","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-05-09T06:01:44.173765Z","caller":"traceutil/trace.go:171","msg":"trace[49447650] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24719; }","duration":"173.235345ms","start":"2026-05-09T06:01:44.000505Z","end":"2026-05-09T06:01:44.17374Z","steps":["trace[49447650] 'agreement among raft nodes before linearized reading'  (duration: 172.863864ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T06:01:44.462704Z","caller":"traceutil/trace.go:171","msg":"trace[1274758157] transaction","detail":"{read_only:false; response_revision:24720; number_of_response:1; }","duration":"285.131453ms","start":"2026-05-09T06:01:44.177541Z","end":"2026-05-09T06:01:44.462672Z","steps":["trace[1274758157] 'process raft request'  (duration: 284.698951ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T06:01:44.502034Z","caller":"traceutil/trace.go:171","msg":"trace[1833610471] transaction","detail":"{read_only:false; response_revision:24722; number_of_response:1; }","duration":"323.147685ms","start":"2026-05-09T06:01:44.178859Z","end":"2026-05-09T06:01:44.502007Z","steps":["trace[1833610471] 'process raft request'  (duration: 323.032152ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T06:01:44.502053Z","caller":"traceutil/trace.go:171","msg":"trace[1553589086] transaction","detail":"{read_only:false; response_revision:24721; number_of_response:1; }","duration":"323.165986ms","start":"2026-05-09T06:01:44.178847Z","end":"2026-05-09T06:01:44.502013Z","steps":["trace[1553589086] 'process raft request'  (duration: 322.846767ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T06:01:44.502255Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T06:01:44.178836Z","time spent":"323.28766ms","remote":"127.0.0.1:58736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:24703 > 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":"warn","ts":"2026-05-09T06:01:44.502275Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T06:01:44.178821Z","time spent":"323.32177ms","remote":"127.0.0.1:58736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:24702 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-05-09T06:01:44.50241Z","caller":"traceutil/trace.go:171","msg":"trace[2092563979] transaction","detail":"{read_only:false; response_revision:24723; number_of_response:1; }","duration":"116.627798ms","start":"2026-05-09T06:01:44.385761Z","end":"2026-05-09T06:01:44.502389Z","steps":["trace[2092563979] 'process raft request'  (duration: 116.187856ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T06:01:44.502413Z","caller":"traceutil/trace.go:171","msg":"trace[1014716922] linearizableReadLoop","detail":"{readStateIndex:25531; appliedIndex:25528; }","duration":"315.420076ms","start":"2026-05-09T06:01:44.186968Z","end":"2026-05-09T06:01:44.502388Z","steps":["trace[1014716922] 'read index received'  (duration: 275.354868ms)","trace[1014716922] 'applied index is now lower than readState.Index'  (duration: 40.063278ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T06:01:44.502647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.208501ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusterrestores/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterrestores0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-05-09T06:01:44.502675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.686323ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"}
{"level":"info","ts":"2026-05-09T06:01:44.502699Z","caller":"traceutil/trace.go:171","msg":"trace[15059576] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusterrestores/; range_end:/registry/pxc.percona.com/perconaxtradbclusterrestores0; response_count:0; response_revision:24723; }","duration":"139.397536ms","start":"2026-05-09T06:01:44.363288Z","end":"2026-05-09T06:01:44.502685Z","steps":["trace[15059576] 'agreement among raft nodes before linearized reading'  (duration: 139.218981ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T06:01:44.502739Z","caller":"traceutil/trace.go:171","msg":"trace[140905380] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24723; }","duration":"315.771965ms","start":"2026-05-09T06:01:44.186946Z","end":"2026-05-09T06:01:44.502718Z","steps":["trace[140905380] 'agreement among raft nodes before linearized reading'  (duration: 315.543818ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T06:01:44.502778Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T06:01:44.186934Z","time spent":"315.833487ms","remote":"127.0.0.1:58736","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":505,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-05-09T06:01:45.048242Z","caller":"traceutil/trace.go:171","msg":"trace[1774637664] linearizableReadLoop","detail":"{readStateIndex:25534; appliedIndex:25533; }","duration":"220.887228ms","start":"2026-05-09T06:01:44.82733Z","end":"2026-05-09T06:01:45.048218Z","steps":["trace[1774637664] 'read index received'  (duration: 220.792836ms)","trace[1774637664] 'applied index is now lower than readState.Index'  (duration: 89.782µs)"],"step_count":2}
{"level":"info","ts":"2026-05-09T06:01:45.048348Z","caller":"traceutil/trace.go:171","msg":"trace[2067017267] transaction","detail":"{read_only:false; response_revision:24725; number_of_response:1; }","duration":"287.941539ms","start":"2026-05-09T06:01:44.760398Z","end":"2026-05-09T06:01:45.04834Z","steps":["trace[2067017267] 'process raft request'  (duration: 287.593279ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T06:01:45.0485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.154985ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-09T06:01:45.048531Z","caller":"traceutil/trace.go:171","msg":"trace[866632597] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24725; }","duration":"221.266068ms","start":"2026-05-09T06:01:44.827258Z","end":"2026-05-09T06:01:45.048525Z","steps":["trace[866632597] 'agreement among raft nodes before linearized reading'  (duration: 221.189956ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T06:01:45.225965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.10633ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13313095744242006549 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:24653 > 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-05-09T06:01:45.226096Z","caller":"traceutil/trace.go:171","msg":"trace[1385884443] linearizableReadLoop","detail":"{readStateIndex:25535; appliedIndex:25534; }","duration":"177.769666ms","start":"2026-05-09T06:01:45.048306Z","end":"2026-05-09T06:01:45.226076Z","steps":["trace[1385884443] 'read index received'  (duration: 53.338268ms)","trace[1385884443] 'applied index is now lower than readState.Index'  (duration: 124.429528ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T06:01:45.226121Z","caller":"traceutil/trace.go:171","msg":"trace[2116098060] transaction","detail":"{read_only:false; response_revision:24726; number_of_response:1; }","duration":"196.793573ms","start":"2026-05-09T06:01:45.029286Z","end":"2026-05-09T06:01:45.22608Z","steps":["trace[2116098060] 'process raft request'  (duration: 72.439007ms)","trace[2116098060] 'compare'  (duration: 123.831792ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T06:01:45.226255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"374.87068ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/addressscopes/\" range_end:\"/registry/openstack.k-orc.cloud/addressscopes0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-09T06:01:45.226292Z","caller":"traceutil/trace.go:171","msg":"trace[1546598967] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/addressscopes/; range_end:/registry/openstack.k-orc.cloud/addressscopes0; response_count:0; response_revision:24726; }","duration":"374.904881ms","start":"2026-05-09T06:01:44.851371Z","end":"2026-05-09T06:01:45.226276Z","steps":["trace[1546598967] 'agreement among raft nodes before linearized reading'  (duration: 374.818588ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T06:01:45.226268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.421586ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.89\" ","response":"range_response_count:1 size:137"}
{"level":"warn","ts":"2026-05-09T06:01:45.226334Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T06:01:44.851324Z","time spent":"374.999063ms","remote":"127.0.0.1:41910","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":30,"request content":"key:\"/registry/openstack.k-orc.cloud/addressscopes/\" range_end:\"/registry/openstack.k-orc.cloud/addressscopes0\" count_only:true "}
{"level":"info","ts":"2026-05-09T06:01:45.226365Z","caller":"traceutil/trace.go:171","msg":"trace[1927388094] range","detail":"{range_begin:/registry/masterleases/199.204.45.89; range_end:; response_count:1; response_revision:24726; }","duration":"216.58616ms","start":"2026-05-09T06:01:45.009756Z","end":"2026-05-09T06:01:45.226342Z","steps":["trace[1927388094] 'agreement among raft nodes before linearized reading'  (duration: 216.345764ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T06:01:45.226392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.250238ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-09T06:01:45.226521Z","caller":"traceutil/trace.go:171","msg":"trace[539449178] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24726; }","duration":"175.444104ms","start":"2026-05-09T06:01:45.051054Z","end":"2026-05-09T06:01:45.226498Z","steps":["trace[539449178] 'agreement among raft nodes before linearized reading'  (duration: 175.241308ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T06:01:45.516687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.775249ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13313095744242006555 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/masterleases/199.204.45.89\" mod_revision:24656 > success:<request_put:<key:\"/registry/masterleases/199.204.45.89\" value_size:67 lease:4089723707387230745 >> failure:<request_range:<key:\"/registry/masterleases/199.204.45.89\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-09T06:01:45.516896Z","caller":"traceutil/trace.go:171","msg":"trace[1186066591] linearizableReadLoop","detail":"{readStateIndex:25537; appliedIndex:25536; }","duration":"255.827257ms","start":"2026-05-09T06:01:45.261044Z","end":"2026-05-09T06:01:45.516871Z","steps":["trace[1186066591] 'read index received'  (duration: 148.682818ms)","trace[1186066591] 'applied index is now lower than readState.Index'  (duration: 107.141269ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T06:01:45.51705Z","caller":"traceutil/trace.go:171","msg":"trace[1488648250] transaction","detail":"{read_only:false; response_revision:24727; number_of_response:1; }","duration":"262.308323ms","start":"2026-05-09T06:01:45.254679Z","end":"2026-05-09T06:01:45.516988Z","steps":["trace[1488648250] 'process raft request'  (duration: 155.111883ms)","trace[1488648250] 'compare'  (duration: 106.284645ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T06:01:45.517214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.158775ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-05-09T06:01:45.517287Z","caller":"traceutil/trace.go:171","msg":"trace[143861866] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:24727; }","duration":"256.241587ms","start":"2026-05-09T06:01:45.261027Z","end":"2026-05-09T06:01:45.517269Z","steps":["trace[143861866] 'agreement among raft nodes before linearized reading'  (duration: 255.97066ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T06:01:45.54231Z","caller":"traceutil/trace.go:171","msg":"trace[1779673825] transaction","detail":"{read_only:false; response_revision:24728; number_of_response:1; }","duration":"241.014064ms","start":"2026-05-09T06:01:45.301246Z","end":"2026-05-09T06:01:45.54226Z","steps":["trace[1779673825] 'process raft request'  (duration: 240.702316ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T06:01:45.542418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.589664ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-05-09T06:01:45.542372Z","caller":"traceutil/trace.go:171","msg":"trace[1090513960] transaction","detail":"{read_only:false; response_revision:24729; number_of_response:1; }","duration":"239.01563ms","start":"2026-05-09T06:01:45.303318Z","end":"2026-05-09T06:01:45.542334Z","steps":["trace[1090513960] 'process raft request'  (duration: 238.832555ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T06:01:45.542488Z","caller":"traceutil/trace.go:171","msg":"trace[584328563] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/; range_end:/registry/validatingwebhookconfigurations0; response_count:0; response_revision:24729; }","duration":"208.746718ms","start":"2026-05-09T06:01:45.333722Z","end":"2026-05-09T06:01:45.542469Z","steps":["trace[584328563] 'agreement among raft nodes before linearized reading'  (duration: 208.563963ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T06:01:45.778715Z","caller":"traceutil/trace.go:171","msg":"trace[776522724] transaction","detail":"{read_only:false; response_revision:24730; number_of_response:1; }","duration":"148.227265ms","start":"2026-05-09T06:01:45.630456Z","end":"2026-05-09T06:01:45.778684Z","steps":["trace[776522724] 'process raft request'  (duration: 148.044ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T06:01:46.021383Z","caller":"traceutil/trace.go:171","msg":"trace[521373254] linearizableReadLoop","detail":"{readStateIndex:25541; appliedIndex:25540; }","duration":"116.486973ms","start":"2026-05-09T06:01:45.904863Z","end":"2026-05-09T06:01:46.02135Z","steps":["trace[521373254] 'read index received'  (duration: 116.171555ms)","trace[521373254] 'applied index is now lower than readState.Index'  (duration: 313.628µs)"],"step_count":2}
{"level":"info","ts":"2026-05-09T06:01:46.021561Z","caller":"traceutil/trace.go:171","msg":"trace[1106199486] transaction","detail":"{read_only:false; response_revision:24731; number_of_response:1; }","duration":"136.729213ms","start":"2026-05-09T06:01:45.884776Z","end":"2026-05-09T06:01:46.021505Z","steps":["trace[1106199486] 'process raft request'  (duration: 136.348383ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T06:01:46.021779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.900455ms","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-05-09T06:01:46.021874Z","caller":"traceutil/trace.go:171","msg":"trace[1643185862] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24731; }","duration":"117.064499ms","start":"2026-05-09T06:01:45.904795Z","end":"2026-05-09T06:01:46.021859Z","steps":["trace[1643185862] 'agreement among raft nodes before linearized reading'  (duration: 116.802472ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T06:01:46.282207Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.048878ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13313095744242006569 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:24716 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-09T06:01:46.282562Z","caller":"traceutil/trace.go:171","msg":"trace[526080769] transaction","detail":"{read_only:false; response_revision:24735; number_of_response:1; }","duration":"103.989144ms","start":"2026-05-09T06:01:46.178557Z","end":"2026-05-09T06:01:46.282546Z","steps":["trace[526080769] 'process raft request'  (duration: 103.903581ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T06:01:46.282581Z","caller":"traceutil/trace.go:171","msg":"trace[912452356] transaction","detail":"{read_only:false; response_revision:24734; number_of_response:1; }","duration":"104.892388ms","start":"2026-05-09T06:01:46.177653Z","end":"2026-05-09T06:01:46.282545Z","steps":["trace[912452356] 'process raft request'  (duration: 104.712793ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T06:01:46.282805Z","caller":"traceutil/trace.go:171","msg":"trace[569097094] transaction","detail":"{read_only:false; response_revision:24733; number_of_response:1; }","duration":"235.963447ms","start":"2026-05-09T06:01:46.046792Z","end":"2026-05-09T06:01:46.282755Z","steps":["trace[569097094] 'process raft request'  (duration: 79.281333ms)","trace[569097094] 'compare'  (duration: 155.833641ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T06:01:46.566036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.845274ms","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-05-09T06:01:46.566303Z","caller":"traceutil/trace.go:171","msg":"trace[1869047190] range","detail":"{range_begin:/registry/cluster.x-k8s.io/clusters/; range_end:/registry/cluster.x-k8s.io/clusters0; response_count:0; response_revision:24735; }","duration":"113.325028ms","start":"2026-05-09T06:01:46.452894Z","end":"2026-05-09T06:01:46.566219Z","steps":["trace[1869047190] 'count revisions from in-memory index tree'  (duration: 112.742642ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T06:01:46.722543Z","caller":"traceutil/trace.go:171","msg":"trace[125828678] linearizableReadLoop","detail":"{readStateIndex:25546; appliedIndex:25545; }","duration":"213.056546ms","start":"2026-05-09T06:01:46.509454Z","end":"2026-05-09T06:01:46.72251Z","steps":["trace[125828678] 'read index received'  (duration: 212.819089ms)","trace[125828678] 'applied index is now lower than readState.Index'  (duration: 235.496µs)"],"step_count":2}
{"level":"info","ts":"2026-05-09T06:01:46.722739Z","caller":"traceutil/trace.go:171","msg":"trace[1311453313] transaction","detail":"{read_only:false; response_revision:24736; number_of_response:1; }","duration":"213.297462ms","start":"2026-05-09T06:01:46.509377Z","end":"2026-05-09T06:01:46.722675Z","steps":["trace[1311453313] 'process raft request'  (duration: 212.814229ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T06:01:46.722931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.449796ms","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-05-09T06:01:46.722983Z","caller":"traceutil/trace.go:171","msg":"trace[1893206913] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:24736; }","duration":"213.574949ms","start":"2026-05-09T06:01:46.509391Z","end":"2026-05-09T06:01:46.722966Z","steps":["trace[1893206913] 'agreement among raft nodes before linearized reading'  (duration: 213.285171ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T06:01:46.741796Z","caller":"traceutil/trace.go:171","msg":"trace[1087152857] transaction","detail":"{read_only:false; response_revision:24737; number_of_response:1; }","duration":"217.746843ms","start":"2026-05-09T06:01:46.524028Z","end":"2026-05-09T06:01:46.741774Z","steps":["trace[1087152857] 'process raft request'  (duration: 217.205218ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T06:01:46.741787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.748625ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"}
{"level":"info","ts":"2026-05-09T06:01:46.741941Z","caller":"traceutil/trace.go:171","msg":"trace[1881076834] transaction","detail":"{read_only:false; response_revision:24738; number_of_response:1; }","duration":"170.075408ms","start":"2026-05-09T06:01:46.571839Z","end":"2026-05-09T06:01:46.741914Z","steps":["trace[1881076834] 'process raft request'  (duration: 169.613815ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T06:01:46.742037Z","caller":"traceutil/trace.go:171","msg":"trace[1666362383] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24738; }","duration":"203.040993ms","start":"2026-05-09T06:01:46.538934Z","end":"2026-05-09T06:01:46.741975Z","steps":["trace[1666362383] 'agreement among raft nodes before linearized reading'  (duration: 202.633032ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T06:01:46.924833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.783791ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13313095744242006590 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:24724 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-09T06:01:46.925026Z","caller":"traceutil/trace.go:171","msg":"trace[148205415] transaction","detail":"{read_only:false; response_revision:24740; number_of_response:1; }","duration":"178.502018ms","start":"2026-05-09T06:01:46.746466Z","end":"2026-05-09T06:01:46.924968Z","steps":["trace[148205415] 'process raft request'  (duration: 29.47252ms)","trace[148205415] 'compare'  (duration: 148.384489ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T06:01:47.185874Z","caller":"traceutil/trace.go:171","msg":"trace[729477418] transaction","detail":"{read_only:false; response_revision:24741; number_of_response:1; }","duration":"128.459658ms","start":"2026-05-09T06:01:47.057388Z","end":"2026-05-09T06:01:47.185847Z","steps":["trace[729477418] 'process raft request'  (duration: 128.295524ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T06:01:47.710421Z","caller":"traceutil/trace.go:171","msg":"trace[1289575258] transaction","detail":"{read_only:false; response_revision:24742; number_of_response:1; }","duration":"162.256026ms","start":"2026-05-09T06:01:47.548127Z","end":"2026-05-09T06:01:47.710383Z","steps":["trace[1289575258] 'process raft request'  (duration: 162.065441ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T06:01:47.711478Z","caller":"traceutil/trace.go:171","msg":"trace[1692528528] transaction","detail":"{read_only:false; response_revision:24743; number_of_response:1; }","duration":"162.835661ms","start":"2026-05-09T06:01:47.548581Z","end":"2026-05-09T06:01:47.711417Z","steps":["trace[1692528528] 'process raft request'  (duration: 162.633786ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T06:01:51.563012Z","caller":"traceutil/trace.go:171","msg":"trace[1877685521] linearizableReadLoop","detail":"{readStateIndex:25580; appliedIndex:25579; }","duration":"178.387643ms","start":"2026-05-09T06:01:51.384593Z","end":"2026-05-09T06:01:51.562981Z","steps":["trace[1877685521] 'read index received'  (duration: 178.135016ms)","trace[1877685521] 'applied index is now lower than readState.Index'  (duration: 251.247µs)"],"step_count":2}
{"level":"info","ts":"2026-05-09T06:01:51.563125Z","caller":"traceutil/trace.go:171","msg":"trace[1746935302] transaction","detail":"{read_only:false; response_revision:24769; number_of_response:1; }","duration":"259.007303ms","start":"2026-05-09T06:01:51.304073Z","end":"2026-05-09T06:01:51.56308Z","steps":["trace[1746935302] 'process raft request'  (duration: 258.704695ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T06:01:51.563418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.775333ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"}
{"level":"info","ts":"2026-05-09T06:01:51.563467Z","caller":"traceutil/trace.go:171","msg":"trace[1184017233] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:24769; }","duration":"178.916667ms","start":"2026-05-09T06:01:51.384538Z","end":"2026-05-09T06:01:51.563454Z","steps":["trace[1184017233] 'agreement among raft nodes before linearized reading'  (duration: 178.623049ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T06:01:51.563414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.760392ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/keypairs/\" range_end:\"/registry/openstack.k-orc.cloud/keypairs0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-09T06:01:51.5636Z","caller":"traceutil/trace.go:171","msg":"trace[1765836210] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/keypairs/; range_end:/registry/openstack.k-orc.cloud/keypairs0; response_count:0; response_revision:24769; }","duration":"176.002868ms","start":"2026-05-09T06:01:51.387578Z","end":"2026-05-09T06:01:51.563581Z","steps":["trace[1765836210] 'agreement among raft nodes before linearized reading'  (duration: 175.719831ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T06:01:51.817022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.783775ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-09T06:01:51.817114Z","caller":"traceutil/trace.go:171","msg":"trace[1840866013] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:24769; }","duration":"185.954469ms","start":"2026-05-09T06:01:51.63114Z","end":"2026-05-09T06:01:51.817095Z","steps":["trace[1840866013] 'range keys from in-memory index tree'  (duration: 185.689732ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T06:02:00.481421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.867483ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-09T06:02:00.48155Z","caller":"traceutil/trace.go:171","msg":"trace[1963624559] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:24895; }","duration":"198.059498ms","start":"2026-05-09T06:02:00.283463Z","end":"2026-05-09T06:02:00.481523Z","steps":["trace[1963624559] 'count revisions from in-memory index tree'  (duration: 197.73323ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T06:02:00.481609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.738786ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13313095744242006984 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:24821 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-09T06:02:00.481838Z","caller":"traceutil/trace.go:171","msg":"trace[1507936290] linearizableReadLoop","detail":"{readStateIndex:25710; appliedIndex:25708; }","duration":"133.947117ms","start":"2026-05-09T06:02:00.347877Z","end":"2026-05-09T06:02:00.481824Z","steps":["trace[1507936290] 'read index received'  (duration: 4.895253ms)","trace[1507936290] 'applied index is now lower than readState.Index'  (duration: 129.050664ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T06:02:00.482053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.182764ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"}
{"level":"info","ts":"2026-05-09T06:02:00.482089Z","caller":"traceutil/trace.go:171","msg":"trace[331570912] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24897; }","duration":"134.255766ms","start":"2026-05-09T06:02:00.347824Z","end":"2026-05-09T06:02:00.482079Z","steps":["trace[331570912] 'agreement among raft nodes before linearized reading'  (duration: 134.053901ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T06:02:00.48234Z","caller":"traceutil/trace.go:171","msg":"trace[1041779570] transaction","detail":"{read_only:false; response_revision:24897; number_of_response:1; }","duration":"142.266163ms","start":"2026-05-09T06:02:00.340015Z","end":"2026-05-09T06:02:00.482281Z","steps":["trace[1041779570] 'process raft request'  (duration: 141.729509ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T06:02:00.482399Z","caller":"traceutil/trace.go:171","msg":"trace[1378788294] transaction","detail":"{read_only:false; response_revision:24896; number_of_response:1; }","duration":"145.898402ms","start":"2026-05-09T06:02:00.336487Z","end":"2026-05-09T06:02:00.482385Z","steps":["trace[1378788294] 'process raft request'  (duration: 16.297733ms)","trace[1378788294] 'compare'  (duration: 128.466099ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T06:02:00.932532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.626595ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13313095744242006986 > lease_revoke:<id:38c19e0b284f3a19>","response":"size:30"}
{"level":"info","ts":"2026-05-09T06:02:00.933072Z","caller":"traceutil/trace.go:171","msg":"trace[1222545031] linearizableReadLoop","detail":"{readStateIndex:25712; appliedIndex:25710; }","duration":"421.576527ms","start":"2026-05-09T06:02:00.51146Z","end":"2026-05-09T06:02:00.933037Z","steps":["trace[1222545031] 'read index received'  (duration: 96.434248ms)","trace[1222545031] 'applied index is now lower than readState.Index'  (duration: 325.140659ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T06:02:00.933094Z","caller":"traceutil/trace.go:171","msg":"trace[685654822] transaction","detail":"{read_only:false; response_revision:24898; number_of_response:1; }","duration":"446.223667ms","start":"2026-05-09T06:02:00.486821Z","end":"2026-05-09T06:02:00.933045Z","steps":["trace[685654822] 'process raft request'  (duration: 445.846996ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T06:02:00.933301Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T06:02:00.486794Z","time spent":"446.38801ms","remote":"127.0.0.1:58736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:24823 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-05-09T06:02:01.076653Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"565.165776ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-99041259-3b73-46b4-ada2-d685ae316783\" ","response":"range_response_count:1 size:3643"}
{"level":"info","ts":"2026-05-09T06:02:01.076749Z","caller":"traceutil/trace.go:171","msg":"trace[973490803] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-99041259-3b73-46b4-ada2-d685ae316783; range_end:; response_count:1; response_revision:24898; }","duration":"565.327071ms","start":"2026-05-09T06:02:00.511399Z","end":"2026-05-09T06:02:01.076727Z","steps":["trace[973490803] 'agreement among raft nodes before linearized reading'  (duration: 421.790283ms)","trace[973490803] 'range keys from in-memory index tree'  (duration: 143.285391ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T06:02:01.076788Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T06:02:00.511378Z","time spent":"565.402753ms","remote":"127.0.0.1:58672","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3667,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-99041259-3b73-46b4-ada2-d685ae316783\" "}
{"level":"warn","ts":"2026-05-09T06:02:01.076914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.780574ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13313095744242006989 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/capo-system/controller-leader-election-capo\" mod_revision:24829 > success:<request_put:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-09T06:02:01.077052Z","caller":"traceutil/trace.go:171","msg":"trace[1056012132] linearizableReadLoop","detail":"{readStateIndex:25713; appliedIndex:25712; }","duration":"143.876827ms","start":"2026-05-09T06:02:00.933154Z","end":"2026-05-09T06:02:01.07703Z","steps":["trace[1056012132] 'read index received'  (duration: 143.534µs)","trace[1056012132] 'applied index is now lower than readState.Index'  (duration: 143.731503ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T06:02:01.077114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.24009ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-09T06:02:01.077137Z","caller":"traceutil/trace.go:171","msg":"trace[1894192548] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24899; }","duration":"248.283152ms","start":"2026-05-09T06:02:00.828846Z","end":"2026-05-09T06:02:01.077129Z","steps":["trace[1894192548] 'agreement among raft nodes before linearized reading'  (duration: 248.23554ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T06:02:01.07712Z","caller":"traceutil/trace.go:171","msg":"trace[1848804211] transaction","detail":"{read_only:false; response_revision:24899; number_of_response:1; }","duration":"298.829654ms","start":"2026-05-09T06:02:00.778245Z","end":"2026-05-09T06:02:01.077075Z","steps":["trace[1848804211] 'process raft request'  (duration: 154.781173ms)","trace[1848804211] 'compare'  (duration: 143.464436ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T06:02:01.077373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.227573ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-05-09T06:02:01.077325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"501.109797ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-05-09T06:02:01.077397Z","caller":"traceutil/trace.go:171","msg":"trace[476571321] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:24899; }","duration":"307.298435ms","start":"2026-05-09T06:02:00.770089Z","end":"2026-05-09T06:02:01.077388Z","steps":["trace[476571321] 'agreement among raft nodes before linearized reading'  (duration: 307.248863ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T06:02:01.077423Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T06:02:00.770069Z","time spent":"307.348997ms","remote":"127.0.0.1:39458","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":30,"request content":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true "}
{"level":"warn","ts":"2026-05-09T06:02:01.077395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.214827ms","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-05-09T06:02:01.077528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"488.113725ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanes/\" range_end:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanes0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-09T06:02:01.077542Z","caller":"traceutil/trace.go:171","msg":"trace[2055412633] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:24899; }","duration":"249.445084ms","start":"2026-05-09T06:02:00.828065Z","end":"2026-05-09T06:02:01.07751Z","steps":["trace[2055412633] 'agreement among raft nodes before linearized reading'  (duration: 248.97254ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T06:02:01.077568Z","caller":"traceutil/trace.go:171","msg":"trace[1947252595] range","detail":"{range_begin:/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanes/; range_end:/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanes0; response_count:0; response_revision:24899; }","duration":"488.175137ms","start":"2026-05-09T06:02:00.58938Z","end":"2026-05-09T06:02:01.077555Z","steps":["trace[1947252595] 'agreement among raft nodes before linearized reading'  (duration: 488.083755ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T06:02:01.07763Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T06:02:00.589336Z","time spent":"488.28364ms","remote":"127.0.0.1:41816","response type":"/etcdserverpb.KV/Range","request count":0,"request size":128,"response count":0,"response size":30,"request content":"key:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanes/\" range_end:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanes0\" count_only:true "}
{"level":"info","ts":"2026-05-09T06:02:01.077433Z","caller":"traceutil/trace.go:171","msg":"trace[1805210619] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:24899; }","duration":"501.239671ms","start":"2026-05-09T06:02:00.576169Z","end":"2026-05-09T06:02:01.077409Z","steps":["trace[1805210619] 'agreement among raft nodes before linearized reading'  (duration: 501.058355ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T06:02:01.077711Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T06:02:00.57611Z","time spent":"501.59226ms","remote":"127.0.0.1:55746","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":32,"request content":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true "}
{"level":"warn","ts":"2026-05-09T06:02:01.077377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.889296ms","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-05-09T06:02:01.077821Z","caller":"traceutil/trace.go:171","msg":"trace[550407783] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24899; }","duration":"257.386849ms","start":"2026-05-09T06:02:00.820426Z","end":"2026-05-09T06:02:01.077812Z","steps":["trace[550407783] 'agreement among raft nodes before linearized reading'  (duration: 256.71952ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T06:02:01.274255Z","caller":"traceutil/trace.go:171","msg":"trace[957921356] transaction","detail":"{read_only:false; response_revision:24901; number_of_response:1; }","duration":"191.703566ms","start":"2026-05-09T06:02:01.082515Z","end":"2026-05-09T06:02:01.274219Z","steps":["trace[957921356] 'process raft request'  (duration: 191.337146ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T06:02:01.274582Z","caller":"traceutil/trace.go:171","msg":"trace[1451543773] transaction","detail":"{read_only:false; response_revision:24902; number_of_response:1; }","duration":"191.261243ms","start":"2026-05-09T06:02:01.083297Z","end":"2026-05-09T06:02:01.274558Z","steps":["trace[1451543773] 'process raft request'  (duration: 190.812201ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T06:02:01.274901Z","caller":"traceutil/trace.go:171","msg":"trace[973398168] transaction","detail":"{read_only:false; response_revision:24903; number_of_response:1; }","duration":"190.798031ms","start":"2026-05-09T06:02:01.084095Z","end":"2026-05-09T06:02:01.274893Z","steps":["trace[973398168] 'process raft request'  (duration: 190.36476ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T06:02:02.112085Z","caller":"traceutil/trace.go:171","msg":"trace[2074353073] linearizableReadLoop","detail":"{readStateIndex:25722; appliedIndex:25719; }","duration":"122.696682ms","start":"2026-05-09T06:02:01.98936Z","end":"2026-05-09T06:02:02.112056Z","steps":["trace[2074353073] 'read index received'  (duration: 86.460978ms)","trace[2074353073] 'applied index is now lower than readState.Index'  (duration: 36.234524ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T06:02:02.112185Z","caller":"traceutil/trace.go:171","msg":"trace[1008085032] transaction","detail":"{read_only:false; response_revision:24907; number_of_response:1; }","duration":"253.214796ms","start":"2026-05-09T06:02:01.85896Z","end":"2026-05-09T06:02:02.112175Z","steps":["trace[1008085032] 'process raft request'  (duration: 252.908168ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T06:02:02.11229Z","caller":"traceutil/trace.go:171","msg":"trace[120368082] transaction","detail":"{read_only:false; response_revision:24908; number_of_response:1; }","duration":"250.116172ms","start":"2026-05-09T06:02:01.862159Z","end":"2026-05-09T06:02:02.112275Z","steps":["trace[120368082] 'process raft request'  (duration: 249.836994ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T06:02:02.11209Z","caller":"traceutil/trace.go:171","msg":"trace[1598046631] transaction","detail":"{read_only:false; response_revision:24906; number_of_response:1; }","duration":"258.85291ms","start":"2026-05-09T06:02:01.853198Z","end":"2026-05-09T06:02:02.112051Z","steps":["trace[1598046631] 'process raft request'  (duration: 222.528303ms)","trace[1598046631] 'compare'  (duration: 35.69022ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T06:02:02.112638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.256607ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"}
{"level":"info","ts":"2026-05-09T06:02:02.112689Z","caller":"traceutil/trace.go:171","msg":"trace[1517653788] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:24908; }","duration":"123.36582ms","start":"2026-05-09T06:02:01.989312Z","end":"2026-05-09T06:02:02.112677Z","steps":["trace[1517653788] 'agreement among raft nodes before linearized reading'  (duration: 123.171225ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T06:02:03.825066Z","caller":"traceutil/trace.go:171","msg":"trace[769846759] transaction","detail":"{read_only:false; response_revision:24920; number_of_response:1; }","duration":"155.809901ms","start":"2026-05-09T06:02:03.669229Z","end":"2026-05-09T06:02:03.825039Z","steps":["trace[769846759] 'process raft request'  (duration: 155.41258ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T06:02:07.273599Z","caller":"traceutil/trace.go:171","msg":"trace[694515478] linearizableReadLoop","detail":"{readStateIndex:25778; appliedIndex:25777; }","duration":"151.456343ms","start":"2026-05-09T06:02:07.12209Z","end":"2026-05-09T06:02:07.273547Z","steps":["trace[694515478] 'read index received'  (duration: 151.224476ms)","trace[694515478] 'applied index is now lower than readState.Index'  (duration: 230.446µs)"],"step_count":2}
{"level":"info","ts":"2026-05-09T06:02:07.273938Z","caller":"traceutil/trace.go:171","msg":"trace[879154429] transaction","detail":"{read_only:false; response_revision:24963; number_of_response:1; }","duration":"171.873587ms","start":"2026-05-09T06:02:07.102049Z","end":"2026-05-09T06:02:07.273923Z","steps":["trace[879154429] 'process raft request'  (duration: 171.277711ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T06:02:07.274304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.191643ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"info","ts":"2026-05-09T06:02:07.274347Z","caller":"traceutil/trace.go:171","msg":"trace[1864245476] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24963; }","duration":"152.305137ms","start":"2026-05-09T06:02:07.122031Z","end":"2026-05-09T06:02:07.274337Z","steps":["trace[1864245476] 'agreement among raft nodes before linearized reading'  (duration: 152.143772ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T06:02:07.426313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.066022ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13313095744242007141 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:24935 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:367 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-09T06:02:07.426453Z","caller":"traceutil/trace.go:171","msg":"trace[1035747939] linearizableReadLoop","detail":"{readStateIndex:25779; appliedIndex:25778; }","duration":"125.148669ms","start":"2026-05-09T06:02:07.301281Z","end":"2026-05-09T06:02:07.42643Z","steps":["trace[1035747939] 'read index received'  (duration: 73.552µs)","trace[1035747939] 'applied index is now lower than readState.Index'  (duration: 125.073347ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T06:02:07.426748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.438237ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"}
{"level":"info","ts":"2026-05-09T06:02:07.426808Z","caller":"traceutil/trace.go:171","msg":"trace[1694624446] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24964; }","duration":"125.596781ms","start":"2026-05-09T06:02:07.3012Z","end":"2026-05-09T06:02:07.426797Z","steps":["trace[1694624446] 'agreement among raft nodes before linearized reading'  (duration: 125.351214ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T06:02:07.426798Z","caller":"traceutil/trace.go:171","msg":"trace[644566052] transaction","detail":"{read_only:false; response_revision:24964; number_of_response:1; }","duration":"145.518561ms","start":"2026-05-09T06:02:07.28123Z","end":"2026-05-09T06:02:07.426749Z","steps":["trace[644566052] 'process raft request'  (duration: 14.901324ms)","trace[644566052] 'compare'  (duration: 129.60165ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T06:02:07.426918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.866131ms","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-05-09T06:02:07.426981Z","caller":"traceutil/trace.go:171","msg":"trace[238495470] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:24964; }","duration":"125.014255ms","start":"2026-05-09T06:02:07.301947Z","end":"2026-05-09T06:02:07.426961Z","steps":["trace[238495470] 'agreement among raft nodes before linearized reading'  (duration: 124.732657ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T06:02:07.669818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.24081ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13313095744242007145 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:24944 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:464 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-09T06:02:07.670048Z","caller":"traceutil/trace.go:171","msg":"trace[1277495876] linearizableReadLoop","detail":"{readStateIndex:25781; appliedIndex:25779; }","duration":"233.866301ms","start":"2026-05-09T06:02:07.436158Z","end":"2026-05-09T06:02:07.670024Z","steps":["trace[1277495876] 'read index received'  (duration: 129.281762ms)","trace[1277495876] 'applied index is now lower than readState.Index'  (duration: 104.582799ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T06:02:07.670166Z","caller":"traceutil/trace.go:171","msg":"trace[859942240] transaction","detail":"{read_only:false; response_revision:24966; number_of_response:1; }","duration":"238.079815ms","start":"2026-05-09T06:02:07.432076Z","end":"2026-05-09T06:02:07.670156Z","steps":["trace[859942240] 'process raft request'  (duration: 237.874219ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T06:02:07.670304Z","caller":"traceutil/trace.go:171","msg":"trace[106541228] transaction","detail":"{read_only:false; response_revision:24965; number_of_response:1; }","duration":"238.227359ms","start":"2026-05-09T06:02:07.432023Z","end":"2026-05-09T06:02:07.670251Z","steps":["trace[106541228] 'process raft request'  (duration: 133.463505ms)","trace[106541228] 'compare'  (duration: 104.059485ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T06:02:07.670463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.553654ms","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:6"}
{"level":"warn","ts":"2026-05-09T06:02:07.670482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.00792ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-05-09T06:02:07.670556Z","caller":"traceutil/trace.go:171","msg":"trace[1575412312] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:24966; }","duration":"197.767301ms","start":"2026-05-09T06:02:07.472765Z","end":"2026-05-09T06:02:07.670533Z","steps":["trace[1575412312] 'agreement among raft nodes before linearized reading'  (duration: 197.576166ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T06:02:07.67058Z","caller":"traceutil/trace.go:171","msg":"trace[1460944543] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:24966; }","duration":"186.174064ms","start":"2026-05-09T06:02:07.484383Z","end":"2026-05-09T06:02:07.670557Z","steps":["trace[1460944543] 'agreement among raft nodes before linearized reading'  (duration: 185.964389ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T06:02:07.670582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.390925ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"}
{"level":"info","ts":"2026-05-09T06:02:07.670715Z","caller":"traceutil/trace.go:171","msg":"trace[1885439424] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:24966; }","duration":"234.538839ms","start":"2026-05-09T06:02:07.436151Z","end":"2026-05-09T06:02:07.67069Z","steps":["trace[1885439424] 'agreement among raft nodes before linearized reading'  (duration: 234.168569ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T06:02:07.811217Z","caller":"traceutil/trace.go:171","msg":"trace[1140912071] linearizableReadLoop","detail":"{readStateIndex:25782; appliedIndex:25781; }","duration":"126.979598ms","start":"2026-05-09T06:02:07.684206Z","end":"2026-05-09T06:02:07.811186Z","steps":["trace[1140912071] 'read index received'  (duration: 126.443323ms)","trace[1140912071] 'applied index is now lower than readState.Index'  (duration: 534.725µs)"],"step_count":2}
{"level":"info","ts":"2026-05-09T06:02:07.811324Z","caller":"traceutil/trace.go:171","msg":"trace[127429570] transaction","detail":"{read_only:false; response_revision:24967; number_of_response:1; }","duration":"129.760863ms","start":"2026-05-09T06:02:07.681517Z","end":"2026-05-09T06:02:07.811278Z","steps":["trace[127429570] 'process raft request'  (duration: 129.326202ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T06:02:07.811588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.358518ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5652"}
{"level":"info","ts":"2026-05-09T06:02:07.811688Z","caller":"traceutil/trace.go:171","msg":"trace[651234135] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:24967; }","duration":"127.512212ms","start":"2026-05-09T06:02:07.684152Z","end":"2026-05-09T06:02:07.811664Z","steps":["trace[651234135] 'agreement among raft nodes before linearized reading'  (duration: 127.251975ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T06:02:19.885607Z","caller":"traceutil/trace.go:171","msg":"trace[1856382009] transaction","detail":"{read_only:false; response_revision:25069; number_of_response:1; }","duration":"156.974592ms","start":"2026-05-09T06:02:19.728608Z","end":"2026-05-09T06:02:19.885583Z","steps":["trace[1856382009] 'process raft request'  (duration: 156.827778ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T06:02:20.179761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.918208ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13313095744242007403 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:25056 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:464 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-09T06:02:20.179902Z","caller":"traceutil/trace.go:171","msg":"trace[987995099] linearizableReadLoop","detail":"{readStateIndex:25887; appliedIndex:25885; }","duration":"349.425867ms","start":"2026-05-09T06:02:19.830455Z","end":"2026-05-09T06:02:20.179881Z","steps":["trace[987995099] 'read index received'  (duration: 54.9203ms)","trace[987995099] 'applied index is now lower than readState.Index'  (duration: 294.503677ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T06:02:20.17991Z","caller":"traceutil/trace.go:171","msg":"trace[1476384760] transaction","detail":"{read_only:false; response_revision:25070; number_of_response:1; }","duration":"448.17715ms","start":"2026-05-09T06:02:19.731698Z","end":"2026-05-09T06:02:20.179875Z","steps":["trace[1476384760] 'process raft request'  (duration: 304.030306ms)","trace[1476384760] 'compare'  (duration: 143.530418ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T06:02:20.18007Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T06:02:19.731668Z","time spent":"448.326104ms","remote":"127.0.0.1:58736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:25056 > 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":"warn","ts":"2026-05-09T06:02:20.180068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"349.602863ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-09T06:02:20.180166Z","caller":"traceutil/trace.go:171","msg":"trace[2083819343] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25070; }","duration":"349.765067ms","start":"2026-05-09T06:02:19.83038Z","end":"2026-05-09T06:02:20.180145Z","steps":["trace[2083819343] 'agreement among raft nodes before linearized reading'  (duration: 349.579102ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T06:02:20.180173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.183602ms","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-05-09T06:02:20.180217Z","caller":"traceutil/trace.go:171","msg":"trace[914382447] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25070; }","duration":"272.228013ms","start":"2026-05-09T06:02:19.907977Z","end":"2026-05-09T06:02:20.180205Z","steps":["trace[914382447] 'agreement among raft nodes before linearized reading'  (duration: 272.040638ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T06:02:20.180214Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T06:02:19.83036Z","time spent":"349.84645ms","remote":"127.0.0.1:58488","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":30,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-05-09T06:02:20.180794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.323757ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/machinedeployments/\" range_end:\"/registry/cluster.x-k8s.io/machinedeployments0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-09T06:02:20.180913Z","caller":"traceutil/trace.go:171","msg":"trace[907104389] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machinedeployments/; range_end:/registry/cluster.x-k8s.io/machinedeployments0; response_count:0; response_revision:25070; }","duration":"106.516692ms","start":"2026-05-09T06:02:20.074372Z","end":"2026-05-09T06:02:20.180889Z","steps":["trace[907104389] 'agreement among raft nodes before linearized reading'  (duration: 106.278206ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T06:02:20.464232Z","caller":"traceutil/trace.go:171","msg":"trace[865544945] transaction","detail":"{read_only:false; response_revision:25073; number_of_response:1; }","duration":"277.031762ms","start":"2026-05-09T06:02:20.187173Z","end":"2026-05-09T06:02:20.464204Z","steps":["trace[865544945] 'process raft request'  (duration: 276.917279ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T06:02:20.46436Z","caller":"traceutil/trace.go:171","msg":"trace[1098898512] transaction","detail":"{read_only:false; response_revision:25074; number_of_response:1; }","duration":"277.067593ms","start":"2026-05-09T06:02:20.187255Z","end":"2026-05-09T06:02:20.464322Z","steps":["trace[1098898512] 'process raft request'  (duration: 276.912379ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T06:02:20.4645Z","caller":"traceutil/trace.go:171","msg":"trace[745440067] transaction","detail":"{read_only:false; response_revision:25072; number_of_response:1; }","duration":"278.393119ms","start":"2026-05-09T06:02:20.186085Z","end":"2026-05-09T06:02:20.464478Z","steps":["trace[745440067] 'process raft request'  (duration: 273.538507ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T06:02:20.550739Z","caller":"traceutil/trace.go:171","msg":"trace[753542370] transaction","detail":"{read_only:false; response_revision:25075; number_of_response:1; }","duration":"333.146627ms","start":"2026-05-09T06:02:20.217576Z","end":"2026-05-09T06:02:20.550723Z","steps":["trace[753542370] 'process raft request'  (duration: 333.014533ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T06:02:20.550879Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T06:02:20.217545Z","time spent":"333.245779ms","remote":"127.0.0.1:58736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/capi-system/controller-leader-election-capi\" mod_revision:25061 > success:<request_put:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" value_size:453 >> failure:<request_range:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" > >"}
{"level":"warn","ts":"2026-05-09T06:02:20.817964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.244986ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13313095744242007412 > lease_revoke:<id:38c19e0b284f3c25>","response":"size:30"}
{"level":"info","ts":"2026-05-09T06:02:20.818375Z","caller":"traceutil/trace.go:171","msg":"trace[1239336109] linearizableReadLoop","detail":"{readStateIndex:25892; appliedIndex:25888; }","duration":"557.134768ms","start":"2026-05-09T06:02:20.261194Z","end":"2026-05-09T06:02:20.818329Z","steps":["trace[1239336109] 'read index received'  (duration: 198.311515ms)","trace[1239336109] 'applied index is now lower than readState.Index'  (duration: 358.818303ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T06:02:20.818562Z","caller":"traceutil/trace.go:171","msg":"trace[95222590] transaction","detail":"{read_only:false; response_revision:25076; number_of_response:1; }","duration":"253.208855ms","start":"2026-05-09T06:02:20.565325Z","end":"2026-05-09T06:02:20.818534Z","steps":["trace[95222590] 'process raft request'  (duration: 252.881247ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T06:02:20.818621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"557.407315ms","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-05-09T06:02:20.818657Z","caller":"traceutil/trace.go:171","msg":"trace[1399888877] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25076; }","duration":"557.499229ms","start":"2026-05-09T06:02:20.261149Z","end":"2026-05-09T06:02:20.818648Z","steps":["trace[1399888877] 'agreement among raft nodes before linearized reading'  (duration: 557.301863ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T06:02:20.818681Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T06:02:20.261134Z","time spent":"557.54166ms","remote":"127.0.0.1:58736","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":463,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-05-09T06:02:20.818836Z","caller":"traceutil/trace.go:171","msg":"trace[1997578760] transaction","detail":"{read_only:false; response_revision:25077; number_of_response:1; }","duration":"251.714215ms","start":"2026-05-09T06:02:20.567069Z","end":"2026-05-09T06:02:20.818783Z","steps":["trace[1997578760] 'process raft request'  (duration: 251.357535ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T06:02:21.066634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.659589ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13313095744242007416 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:25062 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-09T06:02:21.066825Z","caller":"traceutil/trace.go:171","msg":"trace[824827909] transaction","detail":"{read_only:false; response_revision:25078; number_of_response:1; }","duration":"243.563604ms","start":"2026-05-09T06:02:20.823216Z","end":"2026-05-09T06:02:21.06678Z","steps":["trace[824827909] 'process raft request'  (duration: 109.672968ms)","trace[824827909] 'compare'  (duration: 133.520766ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T06:02:21.334215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.946461ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13313095744242007418 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:25066 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-09T06:02:21.33433Z","caller":"traceutil/trace.go:171","msg":"trace[1109905649] transaction","detail":"{read_only:false; response_revision:25079; number_of_response:1; }","duration":"263.440624ms","start":"2026-05-09T06:02:21.07087Z","end":"2026-05-09T06:02:21.334311Z","steps":["trace[1109905649] 'process raft request'  (duration: 123.316299ms)","trace[1109905649] 'compare'  (duration: 139.658641ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T06:02:21.633745Z","caller":"traceutil/trace.go:171","msg":"trace[2119222634] linearizableReadLoop","detail":"{readStateIndex:25898; appliedIndex:25897; }","duration":"133.972967ms","start":"2026-05-09T06:02:21.499724Z","end":"2026-05-09T06:02:21.633697Z","steps":["trace[2119222634] 'read index received'  (duration: 133.834754ms)","trace[2119222634] 'applied index is now lower than readState.Index'  (duration: 136.743µs)"],"step_count":2}
{"level":"info","ts":"2026-05-09T06:02:21.63389Z","caller":"traceutil/trace.go:171","msg":"trace[2047304216] transaction","detail":"{read_only:false; response_revision:25080; number_of_response:1; }","duration":"294.450775ms","start":"2026-05-09T06:02:21.339383Z","end":"2026-05-09T06:02:21.633834Z","steps":["trace[2047304216] 'process raft request'  (duration: 294.156647ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T06:02:21.634093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.351778ms","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-05-09T06:02:21.634136Z","caller":"traceutil/trace.go:171","msg":"trace[1969496322] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25080; }","duration":"134.456441ms","start":"2026-05-09T06:02:21.499666Z","end":"2026-05-09T06:02:21.634122Z","steps":["trace[1969496322] 'agreement among raft nodes before linearized reading'  (duration: 134.200684ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T06:02:21.77421Z","caller":"traceutil/trace.go:171","msg":"trace[947574922] transaction","detail":"{read_only:false; response_revision:25081; number_of_response:1; }","duration":"133.30779ms","start":"2026-05-09T06:02:21.64086Z","end":"2026-05-09T06:02:21.774168Z","steps":["trace[947574922] 'process raft request'  (duration: 101.878065ms)","trace[947574922] 'compare'  (duration: 31.212279ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T06:02:22.696649Z","caller":"traceutil/trace.go:171","msg":"trace[1608171925] transaction","detail":"{read_only:false; response_revision:25088; number_of_response:1; }","duration":"138.320957ms","start":"2026-05-09T06:02:22.558295Z","end":"2026-05-09T06:02:22.696616Z","steps":["trace[1608171925] 'process raft request'  (duration: 138.266095ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T06:02:22.697083Z","caller":"traceutil/trace.go:171","msg":"trace[1289454629] transaction","detail":"{read_only:false; response_revision:25086; number_of_response:1; }","duration":"226.046869ms","start":"2026-05-09T06:02:22.47102Z","end":"2026-05-09T06:02:22.697067Z","steps":["trace[1289454629] 'process raft request'  (duration: 147.781883ms)","trace[1289454629] 'compare'  (duration: 77.499195ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T06:02:22.697148Z","caller":"traceutil/trace.go:171","msg":"trace[501807990] linearizableReadLoop","detail":"{readStateIndex:25905; appliedIndex:25902; }","duration":"188.382725ms","start":"2026-05-09T06:02:22.508723Z","end":"2026-05-09T06:02:22.697106Z","steps":["trace[501807990] 'read index received'  (duration: 7.916325ms)","trace[501807990] 'applied index is now lower than readState.Index'  (duration: 180.46354ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T06:02:22.697158Z","caller":"traceutil/trace.go:171","msg":"trace[1182778041] transaction","detail":"{read_only:false; response_revision:25087; number_of_response:1; }","duration":"224.030174ms","start":"2026-05-09T06:02:22.473086Z","end":"2026-05-09T06:02:22.697116Z","steps":["trace[1182778041] 'process raft request'  (duration: 223.403687ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T06:02:22.697362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.608671ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/superstreams/\" range_end:\"/registry/rabbitmq.com/superstreams0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-09T06:02:22.697462Z","caller":"traceutil/trace.go:171","msg":"trace[1214592866] range","detail":"{range_begin:/registry/rabbitmq.com/superstreams/; range_end:/registry/rabbitmq.com/superstreams0; response_count:0; response_revision:25088; }","duration":"188.734065ms","start":"2026-05-09T06:02:22.508706Z","end":"2026-05-09T06:02:22.69744Z","steps":["trace[1214592866] 'agreement among raft nodes before linearized reading'  (duration: 188.54767ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T06:02:22.950221Z","caller":"traceutil/trace.go:171","msg":"trace[23590830] transaction","detail":"{read_only:false; response_revision:25089; number_of_response:1; }","duration":"126.362632ms","start":"2026-05-09T06:02:22.823827Z","end":"2026-05-09T06:02:22.95019Z","steps":["trace[23590830] 'process raft request'  (duration: 126.160046ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T06:02:23.015505Z","caller":"traceutil/trace.go:171","msg":"trace[640453534] linearizableReadLoop","detail":"{readStateIndex:25908; appliedIndex:25906; }","duration":"175.784683ms","start":"2026-05-09T06:02:22.839688Z","end":"2026-05-09T06:02:23.015473Z","steps":["trace[640453534] 'read index received'  (duration: 110.357936ms)","trace[640453534] 'applied index is now lower than readState.Index'  (duration: 65.425487ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T06:02:23.015683Z","caller":"traceutil/trace.go:171","msg":"trace[1127848979] transaction","detail":"{read_only:false; response_revision:25090; number_of_response:1; }","duration":"189.259179ms","start":"2026-05-09T06:02:22.826376Z","end":"2026-05-09T06:02:23.015635Z","steps":["trace[1127848979] 'process raft request'  (duration: 188.945161ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T06:02:23.01575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.042701ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-neutron-server-0\" ","response":"range_response_count:1 size:1862"}
{"level":"info","ts":"2026-05-09T06:02:23.01592Z","caller":"traceutil/trace.go:171","msg":"trace[339233060] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-neutron-server-0; range_end:; response_count:1; response_revision:25090; }","duration":"176.262917ms","start":"2026-05-09T06:02:22.839638Z","end":"2026-05-09T06:02:23.015901Z","steps":["trace[339233060] 'agreement among raft nodes before linearized reading'  (duration: 175.962829ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T06:02:24.028357Z","caller":"traceutil/trace.go:171","msg":"trace[1160448472] transaction","detail":"{read_only:false; response_revision:25096; number_of_response:1; }","duration":"126.446503ms","start":"2026-05-09T06:02:23.901881Z","end":"2026-05-09T06:02:24.028328Z","steps":["trace[1160448472] 'process raft request'  (duration: 125.769755ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T06:02:27.650182Z","caller":"traceutil/trace.go:171","msg":"trace[500333314] linearizableReadLoop","detail":"{readStateIndex:25952; appliedIndex:25951; }","duration":"144.259907ms","start":"2026-05-09T06:02:27.50589Z","end":"2026-05-09T06:02:27.65015Z","steps":["trace[500333314] 'read index received'  (duration: 144.035661ms)","trace[500333314] 'applied index is now lower than readState.Index'  (duration: 222.306µs)"],"step_count":2}
{"level":"info","ts":"2026-05-09T06:02:27.6503Z","caller":"traceutil/trace.go:171","msg":"trace[1535317477] transaction","detail":"{read_only:false; response_revision:25133; number_of_response:1; }","duration":"152.943533ms","start":"2026-05-09T06:02:27.497311Z","end":"2026-05-09T06:02:27.650254Z","steps":["trace[1535317477] 'process raft request'  (duration: 152.621324ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T06:02:27.650491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.515683ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.carvel.dev/secretimports/\" range_end:\"/registry/secretgen.carvel.dev/secretimports0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-09T06:02:27.650632Z","caller":"traceutil/trace.go:171","msg":"trace[939771615] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secretimports/; range_end:/registry/secretgen.carvel.dev/secretimports0; response_count:0; response_revision:25133; }","duration":"144.736219ms","start":"2026-05-09T06:02:27.505839Z","end":"2026-05-09T06:02:27.650576Z","steps":["trace[939771615] 'agreement among raft nodes before linearized reading'  (duration: 144.429791ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T06:02:29.6159Z","caller":"traceutil/trace.go:171","msg":"trace[2010022819] transaction","detail":"{read_only:false; response_revision:25153; number_of_response:1; }","duration":"113.42712ms","start":"2026-05-09T06:02:29.502423Z","end":"2026-05-09T06:02:29.61585Z","steps":["trace[2010022819] 'process raft request'  (duration: 77.575836ms)","trace[2010022819] 'compare'  (duration: 35.146205ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T06:02:44.077863Z","caller":"traceutil/trace.go:171","msg":"trace[1461730161] linearizableReadLoop","detail":"{readStateIndex:26088; appliedIndex:26087; }","duration":"121.716014ms","start":"2026-05-09T06:02:43.956117Z","end":"2026-05-09T06:02:44.077832Z","steps":["trace[1461730161] 'read index received'  (duration: 121.420386ms)","trace[1461730161] 'applied index is now lower than readState.Index'  (duration: 294.358µs)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T06:02:44.078227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.070084ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:18367"}
{"level":"info","ts":"2026-05-09T06:02:44.078302Z","caller":"traceutil/trace.go:171","msg":"trace[1485141534] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:25266; }","duration":"122.185386ms","start":"2026-05-09T06:02:43.956102Z","end":"2026-05-09T06:02:44.078287Z","steps":["trace[1485141534] 'agreement among raft nodes before linearized reading'  (duration: 121.869488ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T06:02:44.07835Z","caller":"traceutil/trace.go:171","msg":"trace[756981118] transaction","detail":"{read_only:false; response_revision:25266; number_of_response:1; }","duration":"122.940567ms","start":"2026-05-09T06:02:43.955368Z","end":"2026-05-09T06:02:44.078308Z","steps":["trace[756981118] 'process raft request'  (duration: 122.253719ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T06:02:44.243158Z","caller":"traceutil/trace.go:171","msg":"trace[1073108041] transaction","detail":"{read_only:false; response_revision:25267; number_of_response:1; }","duration":"105.570656ms","start":"2026-05-09T06:02:44.137548Z","end":"2026-05-09T06:02:44.243118Z","steps":["trace[1073108041] 'process raft request'  (duration: 22.227182ms)","trace[1073108041] 'compare'  (duration: 82.674796ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T06:02:54.466479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.11399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"}
{"level":"info","ts":"2026-05-09T06:02:54.466572Z","caller":"traceutil/trace.go:171","msg":"trace[81942450] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25340; }","duration":"103.276944ms","start":"2026-05-09T06:02:54.363277Z","end":"2026-05-09T06:02:54.466554Z","steps":["trace[81942450] 'range keys from in-memory index tree'  (duration: 102.942985ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T06:02:54.671226Z","caller":"traceutil/trace.go:171","msg":"trace[192674133] linearizableReadLoop","detail":"{readStateIndex:26167; appliedIndex:26166; }","duration":"177.09978ms","start":"2026-05-09T06:02:54.494093Z","end":"2026-05-09T06:02:54.671192Z","steps":["trace[192674133] 'read index received'  (duration: 113.951565ms)","trace[192674133] 'applied index is now lower than readState.Index'  (duration: 63.147065ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T06:02:54.671318Z","caller":"traceutil/trace.go:171","msg":"trace[1012923371] transaction","detail":"{read_only:false; response_revision:25343; number_of_response:1; }","duration":"177.653604ms","start":"2026-05-09T06:02:54.493613Z","end":"2026-05-09T06:02:54.671266Z","steps":["trace[1012923371] 'process raft request'  (duration: 114.5476ms)","trace[1012923371] 'compare'  (duration: 62.841927ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T06:02:54.671468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.333256ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/magnum-system/\" range_end:\"/registry/endpointslices/magnum-system0\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-09T06:02:54.671521Z","caller":"traceutil/trace.go:171","msg":"trace[53458313] range","detail":"{range_begin:/registry/endpointslices/magnum-system/; range_end:/registry/endpointslices/magnum-system0; response_count:0; response_revision:25343; }","duration":"177.44584ms","start":"2026-05-09T06:02:54.49406Z","end":"2026-05-09T06:02:54.671506Z","steps":["trace[53458313] 'agreement among raft nodes before linearized reading'  (duration: 177.322756ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T06:02:54.67153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.932534ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-09T06:02:54.671633Z","caller":"traceutil/trace.go:171","msg":"trace[2028791997] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:25343; }","duration":"107.128609ms","start":"2026-05-09T06:02:54.56448Z","end":"2026-05-09T06:02:54.671608Z","steps":["trace[2028791997] 'agreement among raft nodes before linearized reading'  (duration: 106.921494ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T06:02:54.959087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.283233ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-05-09T06:02:54.959203Z","caller":"traceutil/trace.go:171","msg":"trace[1725151390] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:25343; }","duration":"184.457439ms","start":"2026-05-09T06:02:54.774725Z","end":"2026-05-09T06:02:54.959183Z","steps":["trace[1725151390] 'count revisions from in-memory index tree'  (duration: 184.203611ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T06:02:54.960147Z","caller":"traceutil/trace.go:171","msg":"trace[881340983] transaction","detail":"{read_only:false; response_revision:25344; number_of_response:1; }","duration":"185.198169ms","start":"2026-05-09T06:02:54.774916Z","end":"2026-05-09T06:02:54.960114Z","steps":["trace[881340983] 'process raft request'  (duration: 184.963773ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T06:02:55.157283Z","caller":"traceutil/trace.go:171","msg":"trace[1594620847] linearizableReadLoop","detail":"{readStateIndex:26171; appliedIndex:26170; }","duration":"144.029081ms","start":"2026-05-09T06:02:55.013222Z","end":"2026-05-09T06:02:55.157251Z","steps":["trace[1594620847] 'read index received'  (duration: 86.625493ms)","trace[1594620847] 'applied index is now lower than readState.Index'  (duration: 57.401758ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T06:02:55.157316Z","caller":"traceutil/trace.go:171","msg":"trace[1748404364] transaction","detail":"{read_only:false; response_revision:25347; number_of_response:1; }","duration":"174.58334ms","start":"2026-05-09T06:02:54.982707Z","end":"2026-05-09T06:02:55.157291Z","steps":["trace[1748404364] 'process raft request'  (duration: 117.210173ms)","trace[1748404364] 'compare'  (duration: 57.150711ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T06:02:55.157659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.402941ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.89\" ","response":"range_response_count:1 size:137"}
{"level":"info","ts":"2026-05-09T06:02:55.157787Z","caller":"traceutil/trace.go:171","msg":"trace[455765146] range","detail":"{range_begin:/registry/masterleases/199.204.45.89; range_end:; response_count:1; response_revision:25347; }","duration":"144.541195ms","start":"2026-05-09T06:02:55.013215Z","end":"2026-05-09T06:02:55.157757Z","steps":["trace[455765146] 'agreement among raft nodes before linearized reading'  (duration: 144.190995ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T06:02:55.49988Z","caller":"traceutil/trace.go:171","msg":"trace[2128152802] transaction","detail":"{read_only:false; response_revision:25348; number_of_response:1; }","duration":"339.643124ms","start":"2026-05-09T06:02:55.16017Z","end":"2026-05-09T06:02:55.499813Z","steps":["trace[2128152802] 'process raft request'  (duration: 285.924574ms)","trace[2128152802] 'compare'  (duration: 53.218075ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T06:02:55.500113Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T06:02:55.160148Z","time spent":"339.853499ms","remote":"127.0.0.1:58736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":508,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:25333 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:453 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-05-09T06:02:55.500204Z","caller":"traceutil/trace.go:171","msg":"trace[494221414] transaction","detail":"{read_only:false; response_revision:25349; number_of_response:1; }","duration":"300.649465ms","start":"2026-05-09T06:02:55.199495Z","end":"2026-05-09T06:02:55.500144Z","steps":["trace[494221414] 'process raft request'  (duration: 300.221102ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T06:02:55.500539Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T06:02:55.199457Z","time spent":"300.920622ms","remote":"127.0.0.1:58736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:25334 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:458 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"info","ts":"2026-05-09T06:02:55.50343Z","caller":"traceutil/trace.go:171","msg":"trace[215103785] transaction","detail":"{read_only:false; response_revision:25350; number_of_response:1; }","duration":"260.322809ms","start":"2026-05-09T06:02:55.243078Z","end":"2026-05-09T06:02:55.503401Z","steps":["trace[215103785] 'process raft request'  (duration: 260.140374ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T06:03:00.304584Z","caller":"traceutil/trace.go:171","msg":"trace[780503196] transaction","detail":"{read_only:false; response_revision:25385; number_of_response:1; }","duration":"118.259782ms","start":"2026-05-09T06:03:00.186291Z","end":"2026-05-09T06:03:00.304551Z","steps":["trace[780503196] 'process raft request'  (duration: 118.035656ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T06:03:00.478148Z","caller":"traceutil/trace.go:171","msg":"trace[849819469] transaction","detail":"{read_only:false; response_revision:25386; number_of_response:1; }","duration":"153.876269ms","start":"2026-05-09T06:03:00.324235Z","end":"2026-05-09T06:03:00.478111Z","steps":["trace[849819469] 'process raft request'  (duration: 99.511562ms)","trace[849819469] 'compare'  (duration: 54.216863ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T06:04:11.777028Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":23184}
{"level":"info","ts":"2026-05-09T06:04:11.924086Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":23184,"took":"141.379965ms","hash":95838633,"current-db-size-bytes":59125760,"current-db-size":"59 MB","current-db-size-in-use-bytes":35295232,"current-db-size-in-use":"35 MB"}
{"level":"info","ts":"2026-05-09T06:04:11.924204Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":95838633,"revision":23184,"compact-revision":20016}
{"level":"info","ts":"2026-05-09T06:04:36.863809Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-0000000000006a3d.wal"}
{"level":"warn","ts":"2026-05-09T06:07:35.312609Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13313095744242014999,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-05-09T06:07:35.451609Z","caller":"traceutil/trace.go:171","msg":"trace[1032518405] transaction","detail":"{read_only:false; response_revision:28099; number_of_response:1; }","duration":"808.077517ms","start":"2026-05-09T06:07:34.643498Z","end":"2026-05-09T06:07:35.451576Z","steps":["trace[1032518405] 'process raft request'  (duration: 807.891042ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T06:07:35.451785Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T06:07:34.643284Z","time spent":"808.412376ms","remote":"127.0.0.1:58736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:28085 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-05-09T06:07:35.452675Z","caller":"traceutil/trace.go:171","msg":"trace[1678119226] linearizableReadLoop","detail":"{readStateIndex:28992; appliedIndex:28990; }","duration":"641.071795ms","start":"2026-05-09T06:07:34.81158Z","end":"2026-05-09T06:07:35.452651Z","steps":["trace[1678119226] 'read index received'  (duration: 639.790941ms)","trace[1678119226] 'applied index is now lower than readState.Index'  (duration: 1.279634ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T06:07:35.452912Z","caller":"traceutil/trace.go:171","msg":"trace[2028417031] transaction","detail":"{read_only:false; response_revision:28100; number_of_response:1; }","duration":"547.444418ms","start":"2026-05-09T06:07:34.905459Z","end":"2026-05-09T06:07:35.452904Z","steps":["trace[2028417031] 'process raft request'  (duration: 547.072688ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T06:07:35.453Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T06:07:34.905435Z","time spent":"547.49903ms","remote":"127.0.0.1:58736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/capo-system/controller-leader-election-capo\" mod_revision:28087 > success:<request_put:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" > >"}
{"level":"warn","ts":"2026-05-09T06:07:35.453024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"625.196073ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-09T06:07:35.453087Z","caller":"traceutil/trace.go:171","msg":"trace[1398423325] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:28100; }","duration":"625.279285ms","start":"2026-05-09T06:07:34.827793Z","end":"2026-05-09T06:07:35.453072Z","steps":["trace[1398423325] 'agreement among raft nodes before linearized reading'  (duration: 625.173082ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T06:07:35.453116Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T06:07:34.827782Z","time spent":"625.329496ms","remote":"127.0.0.1:58488","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":30,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-05-09T06:07:35.453143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"641.558658ms","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-05-09T06:07:35.453175Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"382.224224ms","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-05-09T06:07:35.453226Z","caller":"traceutil/trace.go:171","msg":"trace[1386830765] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:28100; }","duration":"641.700372ms","start":"2026-05-09T06:07:34.811504Z","end":"2026-05-09T06:07:35.453204Z","steps":["trace[1386830765] 'agreement among raft nodes before linearized reading'  (duration: 641.454925ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T06:07:35.453256Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T06:07:34.811458Z","time spent":"641.792804ms","remote":"127.0.0.1:58736","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":519,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"info","ts":"2026-05-09T06:07:35.453256Z","caller":"traceutil/trace.go:171","msg":"trace[1998738376] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:28100; }","duration":"382.321617ms","start":"2026-05-09T06:07:35.070916Z","end":"2026-05-09T06:07:35.453237Z","steps":["trace[1998738376] 'agreement among raft nodes before linearized reading'  (duration: 382.07131ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T06:07:35.453297Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T06:07:35.070836Z","time spent":"382.44992ms","remote":"127.0.0.1:58736","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":463,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-05-09T06:07:35.453265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"421.610916ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.89\" ","response":"range_response_count:1 size:137"}
{"level":"info","ts":"2026-05-09T06:07:35.45335Z","caller":"traceutil/trace.go:171","msg":"trace[1545344027] range","detail":"{range_begin:/registry/masterleases/199.204.45.89; range_end:; response_count:1; response_revision:28100; }","duration":"421.77312ms","start":"2026-05-09T06:07:35.031561Z","end":"2026-05-09T06:07:35.453334Z","steps":["trace[1545344027] 'agreement among raft nodes before linearized reading'  (duration: 421.538584ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T06:07:35.453367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.111633ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-05-09T06:07:35.453386Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T06:07:35.031527Z","time spent":"421.852553ms","remote":"127.0.0.1:58506","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":161,"request content":"key:\"/registry/masterleases/199.204.45.89\" "}
{"level":"info","ts":"2026-05-09T06:07:35.453401Z","caller":"traceutil/trace.go:171","msg":"trace[1682652756] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:28100; }","duration":"239.193745ms","start":"2026-05-09T06:07:35.214199Z","end":"2026-05-09T06:07:35.453393Z","steps":["trace[1682652756] 'agreement among raft nodes before linearized reading'  (duration: 238.912387ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T06:07:35.453754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.119831ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"}
{"level":"info","ts":"2026-05-09T06:07:35.453807Z","caller":"traceutil/trace.go:171","msg":"trace[566070373] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:28100; }","duration":"272.203294ms","start":"2026-05-09T06:07:35.181589Z","end":"2026-05-09T06:07:35.453792Z","steps":["trace[566070373] 'agreement among raft nodes before linearized reading'  (duration: 272.036469ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T06:07:36.262644Z","caller":"traceutil/trace.go:171","msg":"trace[1476993243] linearizableReadLoop","detail":"{readStateIndex:29000; appliedIndex:28999; }","duration":"179.80812ms","start":"2026-05-09T06:07:36.082804Z","end":"2026-05-09T06:07:36.262612Z","steps":["trace[1476993243] 'read index received'  (duration: 179.514692ms)","trace[1476993243] 'applied index is now lower than readState.Index'  (duration: 291.838µs)"],"step_count":2}
{"level":"info","ts":"2026-05-09T06:07:36.262818Z","caller":"traceutil/trace.go:171","msg":"trace[394408423] transaction","detail":"{read_only:false; response_revision:28107; number_of_response:1; }","duration":"262.57673ms","start":"2026-05-09T06:07:36.000183Z","end":"2026-05-09T06:07:36.26276Z","steps":["trace[394408423] 'process raft request'  (duration: 262.18698ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T06:07:36.263027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.18641ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"}
{"level":"info","ts":"2026-05-09T06:07:36.263141Z","caller":"traceutil/trace.go:171","msg":"trace[920915982] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:28107; }","duration":"180.380307ms","start":"2026-05-09T06:07:36.082734Z","end":"2026-05-09T06:07:36.263115Z","steps":["trace[920915982] 'agreement among raft nodes before linearized reading'  (duration: 180.003665ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T06:07:36.265414Z","caller":"traceutil/trace.go:171","msg":"trace[384672996] transaction","detail":"{read_only:false; response_revision:28108; number_of_response:1; }","duration":"149.719222ms","start":"2026-05-09T06:07:36.115677Z","end":"2026-05-09T06:07:36.265396Z","steps":["trace[384672996] 'process raft request'  (duration: 149.467675ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T06:07:36.265868Z","caller":"traceutil/trace.go:171","msg":"trace[1803142264] transaction","detail":"{read_only:false; response_revision:28109; number_of_response:1; }","duration":"142.571506ms","start":"2026-05-09T06:07:36.123258Z","end":"2026-05-09T06:07:36.265829Z","steps":["trace[1803142264] 'process raft request'  (duration: 142.097724ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T06:07:36.266051Z","caller":"traceutil/trace.go:171","msg":"trace[260775583] transaction","detail":"{read_only:false; response_revision:28110; number_of_response:1; }","duration":"141.959541ms","start":"2026-05-09T06:07:36.124049Z","end":"2026-05-09T06:07:36.266009Z","steps":["trace[260775583] 'process raft request'  (duration: 141.673373ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T06:07:38.528963Z","caller":"traceutil/trace.go:171","msg":"trace[1440115828] transaction","detail":"{read_only:false; response_revision:28125; number_of_response:1; }","duration":"170.845337ms","start":"2026-05-09T06:07:38.358084Z","end":"2026-05-09T06:07:38.52893Z","steps":["trace[1440115828] 'process raft request'  (duration: 170.647191ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T06:09:11.783262Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":26128}
{"level":"info","ts":"2026-05-09T06:09:11.934993Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":26128,"took":"142.951098ms","hash":3858926233,"current-db-size-bytes":59125760,"current-db-size":"59 MB","current-db-size-in-use-bytes":34279424,"current-db-size-in-use":"34 MB"}
{"level":"info","ts":"2026-05-09T06:09:11.935066Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3858926233,"revision":26128,"compact-revision":23184}
{"level":"info","ts":"2026-05-09T06:09:49.072062Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"c3b8446219deb8c1","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-05-09T06:09:49.07842Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003}
{"level":"info","ts":"2026-05-09T06:09:49.078518Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003}
{"level":"info","ts":"2026-05-09T06:14:11.792287Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":28802}
{"level":"info","ts":"2026-05-09T06:14:11.934194Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":28802,"took":"136.8827ms","hash":114949635,"current-db-size-bytes":59125760,"current-db-size":"59 MB","current-db-size-in-use-bytes":30060544,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-05-09T06:14:11.934251Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":114949635,"revision":28802,"compact-revision":26128}
{"level":"warn","ts":"2026-05-09T06:15:27.037575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.537652ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/glance-api-55d9bfd9f8-vvdtj.18adcec5cdbf0ef3\" ","response":"range_response_count:1 size:2096"}
{"level":"info","ts":"2026-05-09T06:15:27.037763Z","caller":"traceutil/trace.go:171","msg":"trace[581560305] range","detail":"{range_begin:/registry/events/openstack/glance-api-55d9bfd9f8-vvdtj.18adcec5cdbf0ef3; range_end:; response_count:1; response_revision:31643; }","duration":"197.780018ms","start":"2026-05-09T06:15:26.839959Z","end":"2026-05-09T06:15:27.037739Z","steps":["trace[581560305] 'range keys from in-memory index tree'  (duration: 197.330196ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T06:15:27.037934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.638075ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-09T06:15:27.03807Z","caller":"traceutil/trace.go:171","msg":"trace[1279560547] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:31643; }","duration":"208.852431ms","start":"2026-05-09T06:15:26.829193Z","end":"2026-05-09T06:15:27.038045Z","steps":["trace[1279560547] 'range keys from in-memory index tree'  (duration: 208.506961ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T06:19:11.798624Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":31024}
{"level":"info","ts":"2026-05-09T06:19:11.912008Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":31024,"took":"107.337781ms","hash":1386784909,"current-db-size-bytes":59125760,"current-db-size":"59 MB","current-db-size-in-use-bytes":30887936,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-05-09T06:19:11.912095Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1386784909,"revision":31024,"compact-revision":28802}
{"level":"info","ts":"2026-05-09T06:24:11.805166Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":33287}
{"level":"info","ts":"2026-05-09T06:24:11.958309Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":33287,"took":"146.382003ms","hash":1748570759,"current-db-size-bytes":60166144,"current-db-size":"60 MB","current-db-size-in-use-bytes":31555584,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-05-09T06:24:11.958419Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1748570759,"revision":33287,"compact-revision":31024}
{"level":"info","ts":"2026-05-09T06:29:11.810919Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":35581}
{"level":"info","ts":"2026-05-09T06:29:11.950059Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":35581,"took":"135.129116ms","hash":410675423,"current-db-size-bytes":60588032,"current-db-size":"61 MB","current-db-size-in-use-bytes":31424512,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-05-09T06:29:11.950146Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":410675423,"revision":35581,"compact-revision":33287}
{"level":"info","ts":"2026-05-09T06:31:15.110503Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"c3b8446219deb8c1","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-05-09T06:31:15.116607Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004}
{"level":"info","ts":"2026-05-09T06:31:15.116883Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004}