{"level":"warn","ts":"2026-05-27T06:04:25.450378Z","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-27T06:04:25.450472Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.144: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.144:2380","--initial-cluster=instance=https://199.204.45.144:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.144:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.144: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-27T06:04:25.450558Z","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-27T06:04:25.45057Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.144:2380"]}
{"level":"info","ts":"2026-05-27T06:04:25.450587Z","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-27T06:04:25.451238Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.144:2379"]}
{"level":"info","ts":"2026-05-27T06:04:25.45131Z","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.144:2380"],"listen-peer-urls":["https://199.204.45.144:2380"],"advertise-client-urls":["https://199.204.45.144:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.144:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.144: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-27T06:04:25.456761Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.242891ms"}
{"level":"info","ts":"2026-05-27T06:04:25.465226Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"4594e5f716bad646","cluster-id":"ff2e51b364668606"}
{"level":"info","ts":"2026-05-27T06:04:25.465301Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 switched to configuration voters=()"}
{"level":"info","ts":"2026-05-27T06:04:25.465327Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 became follower at term 0"}
{"level":"info","ts":"2026-05-27T06:04:25.465339Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 4594e5f716bad646 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-05-27T06:04:25.465355Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 became follower at term 1"}
{"level":"info","ts":"2026-05-27T06:04:25.465403Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 switched to configuration voters=(5013885134571230790)"}
{"level":"warn","ts":"2026-05-27T06:04:25.469716Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-05-27T06:04:25.471363Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-05-27T06:04:25.472458Z","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-27T06:04:25.474483Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"4594e5f716bad646","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-05-27T06:04:25.474704Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"4594e5f716bad646","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-05-27T06:04:25.474805Z","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-27T06:04:25.474955Z","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-27T06:04:25.474998Z","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-27T06:04:25.476661Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 switched to configuration voters=(5013885134571230790)"}
{"level":"info","ts":"2026-05-27T06:04:25.477128Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"ff2e51b364668606","local-member-id":"4594e5f716bad646","added-peer-id":"4594e5f716bad646","added-peer-peer-urls":["https://199.204.45.144:2380"]}
{"level":"info","ts":"2026-05-27T06:04:25.479322Z","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-27T06:04:25.479436Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.144:2380"}
{"level":"info","ts":"2026-05-27T06:04:25.479519Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.144:2380"}
{"level":"info","ts":"2026-05-27T06:04:25.479689Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"4594e5f716bad646","initial-advertise-peer-urls":["https://199.204.45.144:2380"],"listen-peer-urls":["https://199.204.45.144:2380"],"advertise-client-urls":["https://199.204.45.144:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.144:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-05-27T06:04:25.479736Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-05-27T06:04:25.565628Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 is starting a new election at term 1"}
{"level":"info","ts":"2026-05-27T06:04:25.565666Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 became pre-candidate at term 1"}
{"level":"info","ts":"2026-05-27T06:04:25.565704Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 received MsgPreVoteResp from 4594e5f716bad646 at term 1"}
{"level":"info","ts":"2026-05-27T06:04:25.565723Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 became candidate at term 2"}
{"level":"info","ts":"2026-05-27T06:04:25.565734Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 received MsgVoteResp from 4594e5f716bad646 at term 2"}
{"level":"info","ts":"2026-05-27T06:04:25.565751Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 became leader at term 2"}
{"level":"info","ts":"2026-05-27T06:04:25.565777Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 4594e5f716bad646 elected leader 4594e5f716bad646 at term 2"}
{"level":"info","ts":"2026-05-27T06:04:25.566467Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-27T06:04:25.567444Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-05-27T06:04:25.567436Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"4594e5f716bad646","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.144:2379]}","request-path":"/0/members/4594e5f716bad646/attributes","cluster-id":"ff2e51b364668606","publish-timeout":"7s"}
{"level":"info","ts":"2026-05-27T06:04:25.567491Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-05-27T06:04:25.56782Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-05-27T06:04:25.567887Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-05-27T06:04:25.567998Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"ff2e51b364668606","local-member-id":"4594e5f716bad646","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-27T06:04:25.568144Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-27T06:04:25.568178Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-27T06:04:25.57041Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.144:2379"}
{"level":"info","ts":"2026-05-27T06:04:25.57093Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-05-27T06:05:05.364373Z","caller":"traceutil/trace.go:171","msg":"trace[1282082822] linearizableReadLoop","detail":"{readStateIndex:588; appliedIndex:587; }","duration":"206.810198ms","start":"2026-05-27T06:05:05.157533Z","end":"2026-05-27T06:05:05.364343Z","steps":["trace[1282082822] 'read index received'  (duration: 206.578733ms)","trace[1282082822] 'applied index is now lower than readState.Index'  (duration: 230.175µs)"],"step_count":2}
{"level":"info","ts":"2026-05-27T06:05:05.36464Z","caller":"traceutil/trace.go:171","msg":"trace[1602016905] transaction","detail":"{read_only:false; response_revision:567; number_of_response:1; }","duration":"208.990329ms","start":"2026-05-27T06:05:05.155636Z","end":"2026-05-27T06:05:05.364626Z","steps":["trace[1602016905] 'process raft request'  (duration: 208.410348ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:05:05.364945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.958221ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-27T06:05:05.367249Z","caller":"traceutil/trace.go:171","msg":"trace[641064406] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:567; }","duration":"150.351928ms","start":"2026-05-27T06:05:05.216871Z","end":"2026-05-27T06:05:05.367223Z","steps":["trace[641064406] 'agreement among raft nodes before linearized reading'  (duration: 147.912181ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:05:05.365172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.649472ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/referencegrants.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:7708"}
{"level":"warn","ts":"2026-05-27T06:05:05.365263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.591355ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-05-27T06:05:05.365403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.444723ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-05-27T06:05:05.36541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.855829ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-05-27T06:05:05.365458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.477791ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-27T06:05:05.367594Z","caller":"traceutil/trace.go:171","msg":"trace[1149714698] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:567; }","duration":"150.643223ms","start":"2026-05-27T06:05:05.216931Z","end":"2026-05-27T06:05:05.367574Z","steps":["trace[1149714698] 'agreement among raft nodes before linearized reading'  (duration: 148.501743ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:05:05.367993Z","caller":"traceutil/trace.go:171","msg":"trace[1418191442] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/referencegrants.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:567; }","duration":"210.509078ms","start":"2026-05-27T06:05:05.157468Z","end":"2026-05-27T06:05:05.367977Z","steps":["trace[1418191442] 'agreement among raft nodes before linearized reading'  (duration: 207.601132ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:05:05.36823Z","caller":"traceutil/trace.go:171","msg":"trace[686494172] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:567; }","duration":"126.612513ms","start":"2026-05-27T06:05:05.241604Z","end":"2026-05-27T06:05:05.368216Z","steps":["trace[686494172] 'agreement among raft nodes before linearized reading'  (duration: 123.554864ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:05:05.368461Z","caller":"traceutil/trace.go:171","msg":"trace[1819442816] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:567; }","duration":"125.507102ms","start":"2026-05-27T06:05:05.24294Z","end":"2026-05-27T06:05:05.368447Z","steps":["trace[1819442816] 'agreement among raft nodes before linearized reading'  (duration: 122.365211ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:05:05.368695Z","caller":"traceutil/trace.go:171","msg":"trace[913494571] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:567; }","duration":"127.182284ms","start":"2026-05-27T06:05:05.241497Z","end":"2026-05-27T06:05:05.368679Z","steps":["trace[913494571] 'agreement among raft nodes before linearized reading'  (duration: 123.839459ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:05:09.829451Z","caller":"traceutil/trace.go:171","msg":"trace[143223546] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"268.521337ms","start":"2026-05-27T06:05:09.560888Z","end":"2026-05-27T06:05:09.82941Z","steps":["trace[143223546] 'process raft request'  (duration: 207.413208ms)","trace[143223546] 'compare'  (duration: 60.707912ms)"],"step_count":2}
{"level":"info","ts":"2026-05-27T06:05:09.830017Z","caller":"traceutil/trace.go:171","msg":"trace[1034633007] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"257.992696ms","start":"2026-05-27T06:05:09.571994Z","end":"2026-05-27T06:05:09.829987Z","steps":["trace[1034633007] 'process raft request'  (duration: 257.508537ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:05:10.3788Z","caller":"traceutil/trace.go:171","msg":"trace[1716863944] linearizableReadLoop","detail":"{readStateIndex:613; appliedIndex:612; }","duration":"489.088698ms","start":"2026-05-27T06:05:09.889667Z","end":"2026-05-27T06:05:10.378756Z","steps":["trace[1716863944] 'read index received'  (duration: 450.645293ms)","trace[1716863944] 'applied index is now lower than readState.Index'  (duration: 38.442045ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-27T06:05:10.378974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"489.279462ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-27T06:05:10.379031Z","caller":"traceutil/trace.go:171","msg":"trace[1677748237] range","detail":"{range_begin:/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:591; }","duration":"489.358123ms","start":"2026-05-27T06:05:09.889648Z","end":"2026-05-27T06:05:10.379006Z","steps":["trace[1677748237] 'agreement among raft nodes before linearized reading'  (duration: 489.2322ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:05:10.379074Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:05:09.889637Z","time spent":"489.428934ms","remote":"127.0.0.1:56202","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":0,"response size":28,"request content":"key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "}
{"level":"info","ts":"2026-05-27T06:05:10.379283Z","caller":"traceutil/trace.go:171","msg":"trace[920031384] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"507.044612ms","start":"2026-05-27T06:05:09.872208Z","end":"2026-05-27T06:05:10.379252Z","steps":["trace[920031384] 'process raft request'  (duration: 468.216559ms)","trace[920031384] 'compare'  (duration: 37.878715ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-27T06:05:10.380037Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:05:09.872169Z","time spent":"507.189205ms","remote":"127.0.0.1:56184","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-5k9v6\" mod_revision:487 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-5k9v6\" value_size:17085 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-5k9v6\" > >"}
{"level":"warn","ts":"2026-05-27T06:05:25.945508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.933339ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15440202542147174275 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:750 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-27T06:05:25.94563Z","caller":"traceutil/trace.go:171","msg":"trace[1005213696] linearizableReadLoop","detail":"{readStateIndex:789; appliedIndex:788; }","duration":"273.056137ms","start":"2026-05-27T06:05:25.672555Z","end":"2026-05-27T06:05:25.945611Z","steps":["trace[1005213696] 'read index received'  (duration: 109.709481ms)","trace[1005213696] 'applied index is now lower than readState.Index'  (duration: 163.345506ms)"],"step_count":2}
{"level":"info","ts":"2026-05-27T06:05:25.945671Z","caller":"traceutil/trace.go:171","msg":"trace[1875529562] transaction","detail":"{read_only:false; response_revision:763; number_of_response:1; }","duration":"279.227674ms","start":"2026-05-27T06:05:25.666405Z","end":"2026-05-27T06:05:25.945633Z","steps":["trace[1875529562] 'process raft request'  (duration: 115.938708ms)","trace[1875529562] 'compare'  (duration: 162.826327ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-27T06:05:25.945789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.175855ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-05-27T06:05:25.945828Z","caller":"traceutil/trace.go:171","msg":"trace[2079475591] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:763; }","duration":"171.237346ms","start":"2026-05-27T06:05:25.774578Z","end":"2026-05-27T06:05:25.945816Z","steps":["trace[2079475591] 'agreement among raft nodes before linearized reading'  (duration: 171.119524ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:05:25.945841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.168489ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-27T06:05:25.94596Z","caller":"traceutil/trace.go:171","msg":"trace[1973888954] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:763; }","duration":"273.386573ms","start":"2026-05-27T06:05:25.67253Z","end":"2026-05-27T06:05:25.945917Z","steps":["trace[1973888954] 'agreement among raft nodes before linearized reading'  (duration: 273.151718ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:06:18.406785Z","caller":"traceutil/trace.go:171","msg":"trace[2127028112] transaction","detail":"{read_only:false; response_revision:1422; number_of_response:1; }","duration":"155.510598ms","start":"2026-05-27T06:06:18.251237Z","end":"2026-05-27T06:06:18.406748Z","steps":["trace[2127028112] 'process raft request'  (duration: 130.346411ms)","trace[2127028112] 'compare'  (duration: 24.835431ms)"],"step_count":2}
{"level":"info","ts":"2026-05-27T06:06:41.560899Z","caller":"traceutil/trace.go:171","msg":"trace[1631676315] linearizableReadLoop","detail":"{readStateIndex:1895; appliedIndex:1894; }","duration":"149.07888ms","start":"2026-05-27T06:06:41.411781Z","end":"2026-05-27T06:06:41.56086Z","steps":["trace[1631676315] 'read index received'  (duration: 148.663632ms)","trace[1631676315] 'applied index is now lower than readState.Index'  (duration: 413.518µs)"],"step_count":2}
{"level":"info","ts":"2026-05-27T06:06:41.561017Z","caller":"traceutil/trace.go:171","msg":"trace[326313910] transaction","detail":"{read_only:false; response_revision:1825; number_of_response:1; }","duration":"213.844359ms","start":"2026-05-27T06:06:41.347128Z","end":"2026-05-27T06:06:41.560973Z","steps":["trace[326313910] 'process raft request'  (duration: 213.503362ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:06:41.561224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.422826ms","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-27T06:06:41.561342Z","caller":"traceutil/trace.go:171","msg":"trace[1928504072] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1825; }","duration":"149.584029ms","start":"2026-05-27T06:06:41.411733Z","end":"2026-05-27T06:06:41.561318Z","steps":["trace[1928504072] 'agreement among raft nodes before linearized reading'  (duration: 149.291634ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:07:32.586943Z","caller":"traceutil/trace.go:171","msg":"trace[856645474] transaction","detail":"{read_only:false; response_revision:2158; number_of_response:1; }","duration":"128.370331ms","start":"2026-05-27T06:07:32.45854Z","end":"2026-05-27T06:07:32.58691Z","steps":["trace[856645474] 'process raft request'  (duration: 128.178317ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:11:19.738771Z","caller":"traceutil/trace.go:171","msg":"trace[1801667028] transaction","detail":"{read_only:false; response_revision:3763; number_of_response:1; }","duration":"124.351878ms","start":"2026-05-27T06:11:19.614382Z","end":"2026-05-27T06:11:19.738734Z","steps":["trace[1801667028] 'process raft request'  (duration: 124.150053ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:12:47.820033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.46344ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-9ff979e5-e106-4b2a-ae95-c61a13c2f5c3\" ","response":"range_response_count:1 size:3601"}
{"level":"info","ts":"2026-05-27T06:12:47.820189Z","caller":"traceutil/trace.go:171","msg":"trace[761030829] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-9ff979e5-e106-4b2a-ae95-c61a13c2f5c3; range_end:; response_count:1; response_revision:4991; }","duration":"208.715104ms","start":"2026-05-27T06:12:47.611441Z","end":"2026-05-27T06:12:47.820156Z","steps":["trace[761030829] 'range keys from in-memory index tree'  (duration: 208.181995ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:12:47.837014Z","caller":"traceutil/trace.go:171","msg":"trace[1315294178] transaction","detail":"{read_only:false; response_revision:4992; number_of_response:1; }","duration":"110.968857ms","start":"2026-05-27T06:12:47.726013Z","end":"2026-05-27T06:12:47.836982Z","steps":["trace[1315294178] 'process raft request'  (duration: 110.745103ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:12:48.177458Z","caller":"traceutil/trace.go:171","msg":"trace[1827650353] linearizableReadLoop","detail":"{readStateIndex:5180; appliedIndex:5179; }","duration":"114.332611ms","start":"2026-05-27T06:12:48.063101Z","end":"2026-05-27T06:12:48.177434Z","steps":["trace[1827650353] 'read index received'  (duration: 114.123707ms)","trace[1827650353] 'applied index is now lower than readState.Index'  (duration: 205.854µs)"],"step_count":2}
{"level":"info","ts":"2026-05-27T06:12:48.17757Z","caller":"traceutil/trace.go:171","msg":"trace[1448812023] transaction","detail":"{read_only:false; response_revision:4995; number_of_response:1; }","duration":"144.025822ms","start":"2026-05-27T06:12:48.033513Z","end":"2026-05-27T06:12:48.177539Z","steps":["trace[1448812023] 'process raft request'  (duration: 143.780187ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:12:48.177987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.878511ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:25 size:786868"}
{"level":"info","ts":"2026-05-27T06:12:48.178024Z","caller":"traceutil/trace.go:171","msg":"trace[2046497762] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:25; response_revision:4995; }","duration":"114.968943ms","start":"2026-05-27T06:12:48.063044Z","end":"2026-05-27T06:12:48.178013Z","steps":["trace[2046497762] 'agreement among raft nodes before linearized reading'  (duration: 114.536825ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:13:07.65114Z","caller":"traceutil/trace.go:171","msg":"trace[994998039] transaction","detail":"{read_only:false; response_revision:5404; number_of_response:1; }","duration":"113.469186ms","start":"2026-05-27T06:13:07.537636Z","end":"2026-05-27T06:13:07.651105Z","steps":["trace[994998039] 'process raft request'  (duration: 99.40667ms)","trace[994998039] 'compare'  (duration: 13.663477ms)"],"step_count":2}
{"level":"info","ts":"2026-05-27T06:14:25.966977Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2968}
{"level":"info","ts":"2026-05-27T06:14:26.035582Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2968,"took":"67.137117ms","hash":1378465990,"current-db-size-bytes":58818560,"current-db-size":"59 MB","current-db-size-in-use-bytes":34242560,"current-db-size-in-use":"34 MB"}
{"level":"info","ts":"2026-05-27T06:14:26.03564Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1378465990,"revision":2968,"compact-revision":-1}
{"level":"info","ts":"2026-05-27T06:19:12.628604Z","caller":"traceutil/trace.go:171","msg":"trace[657421630] transaction","detail":"{read_only:false; response_revision:8223; number_of_response:1; }","duration":"126.45481ms","start":"2026-05-27T06:19:12.502123Z","end":"2026-05-27T06:19:12.628578Z","steps":["trace[657421630] 'process raft request'  (duration: 126.262336ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:19:24.011525Z","caller":"traceutil/trace.go:171","msg":"trace[2079380850] transaction","detail":"{read_only:false; response_revision:8283; number_of_response:1; }","duration":"114.08909ms","start":"2026-05-27T06:19:23.897404Z","end":"2026-05-27T06:19:24.011493Z","steps":["trace[2079380850] 'process raft request'  (duration: 113.885917ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:19:24.321054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.75824ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15440202542147192227 > lease_revoke:<id:56469e6808c444c0>","response":"size:28"}
{"level":"info","ts":"2026-05-27T06:19:26.043857Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6125}
{"level":"warn","ts":"2026-05-27T06:19:26.17926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.946304ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15440202542147192248 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:8283 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-27T06:19:26.179427Z","caller":"traceutil/trace.go:171","msg":"trace[54698042] transaction","detail":"{read_only:false; response_revision:8293; number_of_response:1; }","duration":"131.264971ms","start":"2026-05-27T06:19:26.048126Z","end":"2026-05-27T06:19:26.179391Z","steps":["trace[54698042] 'process raft request'  (duration: 22.060552ms)","trace[54698042] 'compare'  (duration: 74.134144ms)","trace[54698042] 'get key's previous created_revision and leaseID' {req_type:put; key:/registry/leases/kube-system/kube-scheduler; req_size:459; } (duration: 34.648937ms)"],"step_count":3}
{"level":"info","ts":"2026-05-27T06:19:26.449559Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6125,"took":"403.390559ms","hash":48034402,"current-db-size-bytes":58818560,"current-db-size":"59 MB","current-db-size-in-use-bytes":23429120,"current-db-size-in-use":"23 MB"}
{"level":"info","ts":"2026-05-27T06:19:26.449683Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":48034402,"revision":6125,"compact-revision":2968}
{"level":"info","ts":"2026-05-27T06:19:51.853044Z","caller":"traceutil/trace.go:171","msg":"trace[460766786] transaction","detail":"{read_only:false; response_revision:8487; number_of_response:1; }","duration":"373.619534ms","start":"2026-05-27T06:19:51.479396Z","end":"2026-05-27T06:19:51.853015Z","steps":["trace[460766786] 'process raft request'  (duration: 373.3955ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:19:51.853082Z","caller":"traceutil/trace.go:171","msg":"trace[849629024] linearizableReadLoop","detail":"{readStateIndex:8784; appliedIndex:8784; }","duration":"179.270737ms","start":"2026-05-27T06:19:51.673757Z","end":"2026-05-27T06:19:51.853028Z","steps":["trace[849629024] 'read index received'  (duration: 179.257796ms)","trace[849629024] 'applied index is now lower than readState.Index'  (duration: 10.041µs)"],"step_count":2}
{"level":"warn","ts":"2026-05-27T06:19:51.853277Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:19:51.47937Z","time spent":"373.777087ms","remote":"127.0.0.1:56252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:8473 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:465 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-05-27T06:19:51.85338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.597642ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-27T06:19:51.853433Z","caller":"traceutil/trace.go:171","msg":"trace[161989739] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8487; }","duration":"179.720135ms","start":"2026-05-27T06:19:51.6737Z","end":"2026-05-27T06:19:51.85342Z","steps":["trace[161989739] 'agreement among raft nodes before linearized reading'  (duration: 179.538151ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:19:51.853708Z","caller":"traceutil/trace.go:171","msg":"trace[1575373633] transaction","detail":"{read_only:false; response_revision:8488; number_of_response:1; }","duration":"111.609872ms","start":"2026-05-27T06:19:51.742077Z","end":"2026-05-27T06:19:51.853687Z","steps":["trace[1575373633] 'process raft request'  (duration: 111.525371ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:19:51.853908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.025288ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:19384"}
{"level":"info","ts":"2026-05-27T06:19:51.853961Z","caller":"traceutil/trace.go:171","msg":"trace[469498633] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:8488; }","duration":"129.11712ms","start":"2026-05-27T06:19:51.724832Z","end":"2026-05-27T06:19:51.853949Z","steps":["trace[469498633] 'agreement among raft nodes before linearized reading'  (duration: 128.917097ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:20:04.57216Z","caller":"traceutil/trace.go:171","msg":"trace[1992236985] transaction","detail":"{read_only:false; response_revision:8595; number_of_response:1; }","duration":"110.897549ms","start":"2026-05-27T06:20:04.461238Z","end":"2026-05-27T06:20:04.572135Z","steps":["trace[1992236985] 'process raft request'  (duration: 110.786947ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:20:04.885915Z","caller":"traceutil/trace.go:171","msg":"trace[830033329] linearizableReadLoop","detail":"{readStateIndex:8900; appliedIndex:8897; }","duration":"109.559915ms","start":"2026-05-27T06:20:04.776327Z","end":"2026-05-27T06:20:04.885887Z","steps":["trace[830033329] 'read index received'  (duration: 91.6283ms)","trace[830033329] 'applied index is now lower than readState.Index'  (duration: 17.930305ms)"],"step_count":2}
{"level":"info","ts":"2026-05-27T06:20:04.885951Z","caller":"traceutil/trace.go:171","msg":"trace[164800281] transaction","detail":"{read_only:false; response_revision:8597; number_of_response:1; }","duration":"116.383522ms","start":"2026-05-27T06:20:04.769538Z","end":"2026-05-27T06:20:04.885921Z","steps":["trace[164800281] 'process raft request'  (duration: 116.159528ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:20:04.885995Z","caller":"traceutil/trace.go:171","msg":"trace[514381867] transaction","detail":"{read_only:false; response_revision:8598; number_of_response:1; }","duration":"116.284ms","start":"2026-05-27T06:20:04.769674Z","end":"2026-05-27T06:20:04.885958Z","steps":["trace[514381867] 'process raft request'  (duration: 116.165188ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:20:04.886731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.335539ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:26 size:228801"}
{"level":"info","ts":"2026-05-27T06:20:04.886801Z","caller":"traceutil/trace.go:171","msg":"trace[931401363] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:26; response_revision:8598; }","duration":"110.497493ms","start":"2026-05-27T06:20:04.776284Z","end":"2026-05-27T06:20:04.886781Z","steps":["trace[931401363] 'agreement among raft nodes before linearized reading'  (duration: 109.757138ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:20:05.056019Z","caller":"traceutil/trace.go:171","msg":"trace[1057077539] transaction","detail":"{read_only:false; response_revision:8599; number_of_response:1; }","duration":"156.836337ms","start":"2026-05-27T06:20:04.899157Z","end":"2026-05-27T06:20:05.055993Z","steps":["trace[1057077539] 'process raft request'  (duration: 156.680473ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:20:05.095442Z","caller":"traceutil/trace.go:171","msg":"trace[1897980214] transaction","detail":"{read_only:false; response_revision:8600; number_of_response:1; }","duration":"196.04979ms","start":"2026-05-27T06:20:04.899353Z","end":"2026-05-27T06:20:05.095402Z","steps":["trace[1897980214] 'process raft request'  (duration: 195.891037ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:20:06.067308Z","caller":"traceutil/trace.go:171","msg":"trace[1060741344] transaction","detail":"{read_only:false; response_revision:8606; number_of_response:1; }","duration":"120.626611ms","start":"2026-05-27T06:20:05.946638Z","end":"2026-05-27T06:20:06.067265Z","steps":["trace[1060741344] 'process raft request'  (duration: 71.617186ms)","trace[1060741344] 'compare'  (duration: 48.693989ms)"],"step_count":2}
{"level":"info","ts":"2026-05-27T06:20:30.148097Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000023ed.wal"}
{"level":"info","ts":"2026-05-27T06:22:05.516967Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"4594e5f716bad646","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-05-27T06:22:05.523142Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-05-27T06:22:05.523203Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-05-27T06:24:26.050958Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8292}
{"level":"info","ts":"2026-05-27T06:24:26.129253Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8292,"took":"75.910224ms","hash":638818015,"current-db-size-bytes":58818560,"current-db-size":"59 MB","current-db-size-in-use-bytes":25624576,"current-db-size-in-use":"26 MB"}
{"level":"info","ts":"2026-05-27T06:24:26.129314Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":638818015,"revision":8292,"compact-revision":6125}
{"level":"info","ts":"2026-05-27T06:29:26.056394Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10793}
{"level":"info","ts":"2026-05-27T06:29:26.138199Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10793,"took":"78.258459ms","hash":2050257994,"current-db-size-bytes":58818560,"current-db-size":"59 MB","current-db-size-in-use-bytes":27926528,"current-db-size-in-use":"28 MB"}
{"level":"info","ts":"2026-05-27T06:29:26.13826Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2050257994,"revision":10793,"compact-revision":8292}
{"level":"info","ts":"2026-05-27T06:30:50.703681Z","caller":"traceutil/trace.go:171","msg":"trace[1963437186] transaction","detail":"{read_only:false; response_revision:13563; number_of_response:1; }","duration":"110.746149ms","start":"2026-05-27T06:30:50.592893Z","end":"2026-05-27T06:30:50.703639Z","steps":["trace[1963437186] 'process raft request'  (duration: 110.179898ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:30:54.275281Z","caller":"traceutil/trace.go:171","msg":"trace[559136036] linearizableReadLoop","detail":"{readStateIndex:14036; appliedIndex:14035; }","duration":"104.449492ms","start":"2026-05-27T06:30:54.170807Z","end":"2026-05-27T06:30:54.275256Z","steps":["trace[559136036] 'read index received'  (duration: 104.334279ms)","trace[559136036] 'applied index is now lower than readState.Index'  (duration: 114.103µs)"],"step_count":2}
{"level":"info","ts":"2026-05-27T06:30:54.275717Z","caller":"traceutil/trace.go:171","msg":"trace[1313422500] transaction","detail":"{read_only:false; response_revision:13578; number_of_response:1; }","duration":"107.52875ms","start":"2026-05-27T06:30:54.168173Z","end":"2026-05-27T06:30:54.275701Z","steps":["trace[1313422500] 'process raft request'  (duration: 106.938668ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:30:54.276114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.282097ms","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-27T06:30:54.276162Z","caller":"traceutil/trace.go:171","msg":"trace[726024489] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:13578; }","duration":"105.385389ms","start":"2026-05-27T06:30:54.170765Z","end":"2026-05-27T06:30:54.276151Z","steps":["trace[726024489] 'agreement among raft nodes before linearized reading'  (duration: 105.224646ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:30:54.285684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.188005ms","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-27T06:30:54.285756Z","caller":"traceutil/trace.go:171","msg":"trace[1858252766] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:13581; }","duration":"114.296687ms","start":"2026-05-27T06:30:54.171446Z","end":"2026-05-27T06:30:54.285743Z","steps":["trace[1858252766] 'agreement among raft nodes before linearized reading'  (duration: 114.102934ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:30:54.285754Z","caller":"traceutil/trace.go:171","msg":"trace[1726757868] transaction","detail":"{read_only:false; response_revision:13579; number_of_response:1; }","duration":"113.816017ms","start":"2026-05-27T06:30:54.171742Z","end":"2026-05-27T06:30:54.285558Z","steps":["trace[1726757868] 'process raft request'  (duration: 113.595033ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:31:30.600444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.188156ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15440202542147207492 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:13778 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-27T06:31:30.600572Z","caller":"traceutil/trace.go:171","msg":"trace[28699146] linearizableReadLoop","detail":"{readStateIndex:14261; appliedIndex:14259; }","duration":"128.174418ms","start":"2026-05-27T06:31:30.472387Z","end":"2026-05-27T06:31:30.600561Z","steps":["trace[28699146] 'read index received'  (duration: 15.699545ms)","trace[28699146] 'applied index is now lower than readState.Index'  (duration: 112.474163ms)"],"step_count":2}
{"level":"info","ts":"2026-05-27T06:31:30.600632Z","caller":"traceutil/trace.go:171","msg":"trace[889911168] transaction","detail":"{read_only:false; response_revision:13794; number_of_response:1; }","duration":"131.248065ms","start":"2026-05-27T06:31:30.469375Z","end":"2026-05-27T06:31:30.600623Z","steps":["trace[889911168] 'process raft request'  (duration: 131.152603ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:31:30.600667Z","caller":"traceutil/trace.go:171","msg":"trace[1230057273] transaction","detail":"{read_only:false; response_revision:13793; number_of_response:1; }","duration":"131.712834ms","start":"2026-05-27T06:31:30.468906Z","end":"2026-05-27T06:31:30.600619Z","steps":["trace[1230057273] 'compare'  (duration: 129.089835ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:31:30.600992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.570235ms","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-27T06:31:30.601098Z","caller":"traceutil/trace.go:171","msg":"trace[1822993329] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:13794; }","duration":"128.729207ms","start":"2026-05-27T06:31:30.472346Z","end":"2026-05-27T06:31:30.601075Z","steps":["trace[1822993329] 'agreement among raft nodes before linearized reading'  (duration: 128.421371ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:31:30.602915Z","caller":"traceutil/trace.go:171","msg":"trace[262517782] transaction","detail":"{read_only:false; response_revision:13795; number_of_response:1; }","duration":"114.948929ms","start":"2026-05-27T06:31:30.487943Z","end":"2026-05-27T06:31:30.602892Z","steps":["trace[262517782] 'process raft request'  (duration: 114.795716ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:31:38.593396Z","caller":"traceutil/trace.go:171","msg":"trace[2130952982] linearizableReadLoop","detail":"{readStateIndex:14420; appliedIndex:14418; }","duration":"105.016572ms","start":"2026-05-27T06:31:38.488355Z","end":"2026-05-27T06:31:38.593371Z","steps":["trace[2130952982] 'read index received'  (duration: 98.306317ms)","trace[2130952982] 'applied index is now lower than readState.Index'  (duration: 6.709205ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-27T06:31:38.593637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.268868ms","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-27T06:31:38.593677Z","caller":"traceutil/trace.go:171","msg":"trace[1610824] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:13951; }","duration":"105.37317ms","start":"2026-05-27T06:31:38.488294Z","end":"2026-05-27T06:31:38.593667Z","steps":["trace[1610824] 'agreement among raft nodes before linearized reading'  (duration: 105.188515ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:31:38.593644Z","caller":"traceutil/trace.go:171","msg":"trace[1567933235] transaction","detail":"{read_only:false; response_revision:13950; number_of_response:1; }","duration":"149.189002ms","start":"2026-05-27T06:31:38.444413Z","end":"2026-05-27T06:31:38.593602Z","steps":["trace[1567933235] 'process raft request'  (duration: 142.238611ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:31:38.593756Z","caller":"traceutil/trace.go:171","msg":"trace[1286258305] transaction","detail":"{read_only:false; response_revision:13951; number_of_response:1; }","duration":"148.436007ms","start":"2026-05-27T06:31:38.445202Z","end":"2026-05-27T06:31:38.593638Z","steps":["trace[1286258305] 'process raft request'  (duration: 148.09843ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:34:26.06259Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12993}
{"level":"info","ts":"2026-05-27T06:34:26.146662Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12993,"took":"81.132554ms","hash":3948065093,"current-db-size-bytes":58818560,"current-db-size":"59 MB","current-db-size-in-use-bytes":31223808,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-05-27T06:34:26.146767Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3948065093,"revision":12993,"compact-revision":10793}
{"level":"info","ts":"2026-05-27T06:38:54.398535Z","caller":"traceutil/trace.go:171","msg":"trace[107180555] transaction","detail":"{read_only:false; response_revision:17616; number_of_response:1; }","duration":"185.472396ms","start":"2026-05-27T06:38:54.213028Z","end":"2026-05-27T06:38:54.3985Z","steps":["trace[107180555] 'process raft request'  (duration: 185.236802ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:39:00.415696Z","caller":"traceutil/trace.go:171","msg":"trace[1439834170] transaction","detail":"{read_only:false; response_revision:17665; number_of_response:1; }","duration":"229.599126ms","start":"2026-05-27T06:39:00.186055Z","end":"2026-05-27T06:39:00.415655Z","steps":["trace[1439834170] 'process raft request'  (duration: 207.886717ms)","trace[1439834170] 'compare'  (duration: 21.565636ms)"],"step_count":2}
{"level":"info","ts":"2026-05-27T06:39:00.477132Z","caller":"traceutil/trace.go:171","msg":"trace[1108477382] transaction","detail":"{read_only:false; response_revision:17666; number_of_response:1; }","duration":"289.447161ms","start":"2026-05-27T06:39:00.187656Z","end":"2026-05-27T06:39:00.477103Z","steps":["trace[1108477382] 'process raft request'  (duration: 289.193705ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:39:00.477677Z","caller":"traceutil/trace.go:171","msg":"trace[2076757455] transaction","detail":"{read_only:false; response_revision:17667; number_of_response:1; }","duration":"288.688105ms","start":"2026-05-27T06:39:00.188946Z","end":"2026-05-27T06:39:00.477634Z","steps":["trace[2076757455] 'process raft request'  (duration: 288.071634ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:39:00.478102Z","caller":"traceutil/trace.go:171","msg":"trace[82014951] transaction","detail":"{read_only:false; response_revision:17668; number_of_response:1; }","duration":"288.728987ms","start":"2026-05-27T06:39:00.189332Z","end":"2026-05-27T06:39:00.478061Z","steps":["trace[82014951] 'process raft request'  (duration: 288.071685ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:39:01.006387Z","caller":"traceutil/trace.go:171","msg":"trace[1073797744] linearizableReadLoop","detail":"{readStateIndex:18259; appliedIndex:18258; }","duration":"321.747708ms","start":"2026-05-27T06:39:00.684615Z","end":"2026-05-27T06:39:01.006363Z","steps":["trace[1073797744] 'read index received'  (duration: 317.249962ms)","trace[1073797744] 'applied index is now lower than readState.Index'  (duration: 4.496916ms)"],"step_count":2}
{"level":"info","ts":"2026-05-27T06:39:01.00649Z","caller":"traceutil/trace.go:171","msg":"trace[1121723922] transaction","detail":"{read_only:false; response_revision:17669; number_of_response:1; }","duration":"327.73829ms","start":"2026-05-27T06:39:00.678745Z","end":"2026-05-27T06:39:01.006483Z","steps":["trace[1121723922] 'process raft request'  (duration: 322.98711ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:39:01.006596Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:39:00.678708Z","time spent":"327.801591ms","remote":"127.0.0.1:56458","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9491,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/statefulsets/openstack/rabbitmq-heat-server\" mod_revision:17656 > success:<request_put:<key:\"/registry/statefulsets/openstack/rabbitmq-heat-server\" value_size:9430 >> failure:<request_range:<key:\"/registry/statefulsets/openstack/rabbitmq-heat-server\" > >"}
{"level":"warn","ts":"2026-05-27T06:39:01.006776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.162005ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-27T06:39:01.00685Z","caller":"traceutil/trace.go:171","msg":"trace[959216075] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:17669; }","duration":"322.254687ms","start":"2026-05-27T06:39:00.684586Z","end":"2026-05-27T06:39:01.006841Z","steps":["trace[959216075] 'agreement among raft nodes before linearized reading'  (duration: 322.062084ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:39:01.006876Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:39:00.684579Z","time spent":"322.290508ms","remote":"127.0.0.1:46896","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "}
{"level":"warn","ts":"2026-05-27T06:39:01.263072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.65066ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15440202542147221276 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" mod_revision:17604 > success:<request_put:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" value_size:415 >> failure:<request_range:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-27T06:39:01.263197Z","caller":"traceutil/trace.go:171","msg":"trace[1069090330] linearizableReadLoop","detail":"{readStateIndex:18260; appliedIndex:18259; }","duration":"256.721605ms","start":"2026-05-27T06:39:01.006456Z","end":"2026-05-27T06:39:01.263177Z","steps":["trace[1069090330] 'read index received'  (duration: 79.870822ms)","trace[1069090330] 'applied index is now lower than readState.Index'  (duration: 176.849113ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-27T06:39:01.263345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"483.585029ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-27T06:39:01.263379Z","caller":"traceutil/trace.go:171","msg":"trace[848951717] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:17670; }","duration":"483.659281ms","start":"2026-05-27T06:39:00.779709Z","end":"2026-05-27T06:39:01.263369Z","steps":["trace[848951717] 'agreement among raft nodes before linearized reading'  (duration: 483.548009ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:39:01.263413Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:39:00.779684Z","time spent":"483.721001ms","remote":"127.0.0.1:55990","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-27T06:39:01.263402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"400.906825ms","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-27T06:39:01.263414Z","caller":"traceutil/trace.go:171","msg":"trace[1648232927] transaction","detail":"{read_only:false; response_revision:17670; number_of_response:1; }","duration":"512.91459ms","start":"2026-05-27T06:39:00.750451Z","end":"2026-05-27T06:39:01.263366Z","steps":["trace[1648232927] 'process raft request'  (duration: 335.863162ms)","trace[1648232927] 'compare'  (duration: 176.399966ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-27T06:39:01.263472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"401.946875ms","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-27T06:39:01.263481Z","caller":"traceutil/trace.go:171","msg":"trace[864880890] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:17670; }","duration":"401.015487ms","start":"2026-05-27T06:39:00.862445Z","end":"2026-05-27T06:39:01.26346Z","steps":["trace[864880890] 'agreement among raft nodes before linearized reading'  (duration: 400.816504ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:39:01.263581Z","caller":"traceutil/trace.go:171","msg":"trace[1743516490] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:17670; }","duration":"402.131208ms","start":"2026-05-27T06:39:00.861428Z","end":"2026-05-27T06:39:01.263559Z","steps":["trace[1743516490] 'agreement among raft nodes before linearized reading'  (duration: 401.798032ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:39:01.263616Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:39:00.862435Z","time spent":"401.17314ms","remote":"127.0.0.1:56252","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-05-27T06:39:01.263637Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:39:00.861389Z","time spent":"402.2335ms","remote":"127.0.0.1:56252","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":532,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-05-27T06:39:01.263648Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:39:00.750423Z","time spent":"513.108104ms","remote":"127.0.0.1:56252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" mod_revision:17604 > success:<request_put:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" value_size:415 >> failure:<request_range:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" > >"}
{"level":"warn","ts":"2026-05-27T06:39:01.263403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"397.713566ms","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-27T06:39:01.263831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"400.713392ms","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-27T06:39:01.263854Z","caller":"traceutil/trace.go:171","msg":"trace[857148064] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:17670; }","duration":"398.198325ms","start":"2026-05-27T06:39:00.865641Z","end":"2026-05-27T06:39:01.26384Z","steps":["trace[857148064] 'agreement among raft nodes before linearized reading'  (duration: 397.638374ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:39:01.263882Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:39:00.865633Z","time spent":"398.241116ms","remote":"127.0.0.1:56252","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":518,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"info","ts":"2026-05-27T06:39:01.263877Z","caller":"traceutil/trace.go:171","msg":"trace[1043561716] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:17670; }","duration":"400.789044ms","start":"2026-05-27T06:39:00.863075Z","end":"2026-05-27T06:39:01.263864Z","steps":["trace[1043561716] 'agreement among raft nodes before linearized reading'  (duration: 400.138171ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:39:01.263914Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:39:00.863063Z","time spent":"400.843585ms","remote":"127.0.0.1:56252","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-27T06:39:01.263934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"570.826808ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-r8282\" ","response":"range_response_count:1 size:22126"}
{"level":"info","ts":"2026-05-27T06:39:01.264178Z","caller":"traceutil/trace.go:171","msg":"trace[1616357868] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-r8282; range_end:; response_count:1; response_revision:17670; }","duration":"571.126126ms","start":"2026-05-27T06:39:00.692946Z","end":"2026-05-27T06:39:01.264072Z","steps":["trace[1616357868] 'agreement among raft nodes before linearized reading'  (duration: 570.354241ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:39:01.264417Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:39:00.692931Z","time spent":"571.468631ms","remote":"127.0.0.1:56184","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":22149,"request content":"key:\"/registry/pods/openstack/nova-compute-default-r8282\" "}
{"level":"warn","ts":"2026-05-27T06:39:01.265159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.619172ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-gh5l7\" ","response":"range_response_count:1 size:9797"}
{"level":"info","ts":"2026-05-27T06:39:01.265265Z","caller":"traceutil/trace.go:171","msg":"trace[906810179] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-gh5l7; range_end:; response_count:1; response_revision:17670; }","duration":"290.755556ms","start":"2026-05-27T06:39:00.974492Z","end":"2026-05-27T06:39:01.265247Z","steps":["trace[906810179] 'agreement among raft nodes before linearized reading'  (duration: 290.549281ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:39:01.319341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.936781ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12217"}
{"level":"info","ts":"2026-05-27T06:39:01.319535Z","caller":"traceutil/trace.go:171","msg":"trace[1080857784] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:17671; }","duration":"256.174465ms","start":"2026-05-27T06:39:01.063339Z","end":"2026-05-27T06:39:01.319513Z","steps":["trace[1080857784] 'agreement among raft nodes before linearized reading'  (duration: 255.817648ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:39:01.319931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.001024ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephcosidrivers/\" range_end:\"/registry/ceph.rook.io/cephcosidrivers0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-27T06:39:01.320051Z","caller":"traceutil/trace.go:171","msg":"trace[1452247533] range","detail":"{range_begin:/registry/ceph.rook.io/cephcosidrivers/; range_end:/registry/ceph.rook.io/cephcosidrivers0; response_count:0; response_revision:17671; }","duration":"196.163927ms","start":"2026-05-27T06:39:01.123865Z","end":"2026-05-27T06:39:01.320029Z","steps":["trace[1452247533] 'agreement among raft nodes before linearized reading'  (duration: 196.010704ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:39:01.318982Z","caller":"traceutil/trace.go:171","msg":"trace[2076188278] transaction","detail":"{read_only:false; response_revision:17671; number_of_response:1; }","duration":"302.289241ms","start":"2026-05-27T06:39:01.016657Z","end":"2026-05-27T06:39:01.318946Z","steps":["trace[2076188278] 'process raft request'  (duration: 301.767571ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:39:01.320562Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:39:01.01664Z","time spent":"303.829871ms","remote":"127.0.0.1:46838","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3280,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-heat\" mod_revision:17657 > success:<request_put:<key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-heat\" value_size:3209 >> failure:<request_range:<key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-heat\" > >"}
{"level":"info","ts":"2026-05-27T06:39:01.39272Z","caller":"traceutil/trace.go:171","msg":"trace[531067440] transaction","detail":"{read_only:false; response_revision:17672; number_of_response:1; }","duration":"124.102513ms","start":"2026-05-27T06:39:01.268582Z","end":"2026-05-27T06:39:01.392685Z","steps":["trace[531067440] 'process raft request'  (duration: 107.783246ms)","trace[531067440] 'compare'  (duration: 16.073791ms)"],"step_count":2}
{"level":"info","ts":"2026-05-27T06:39:01.392851Z","caller":"traceutil/trace.go:171","msg":"trace[586984347] transaction","detail":"{read_only:false; response_revision:17673; number_of_response:1; }","duration":"124.080112ms","start":"2026-05-27T06:39:01.268736Z","end":"2026-05-27T06:39:01.392816Z","steps":["trace[586984347] 'process raft request'  (duration: 123.849357ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:39:01.393113Z","caller":"traceutil/trace.go:171","msg":"trace[652926781] transaction","detail":"{read_only:false; response_revision:17675; number_of_response:1; }","duration":"123.46434ms","start":"2026-05-27T06:39:01.269638Z","end":"2026-05-27T06:39:01.393102Z","steps":["trace[652926781] 'process raft request'  (duration: 123.377299ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:39:01.393133Z","caller":"traceutil/trace.go:171","msg":"trace[1902956229] transaction","detail":"{read_only:false; response_revision:17674; number_of_response:1; }","duration":"123.92485ms","start":"2026-05-27T06:39:01.269182Z","end":"2026-05-27T06:39:01.393107Z","steps":["trace[1902956229] 'process raft request'  (duration: 123.44758ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:39:01.394207Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.009356ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:96 size:953032"}
{"level":"info","ts":"2026-05-27T06:39:01.394257Z","caller":"traceutil/trace.go:171","msg":"trace[1229313956] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:96; response_revision:17675; }","duration":"120.100197ms","start":"2026-05-27T06:39:01.274146Z","end":"2026-05-27T06:39:01.394246Z","steps":["trace[1229313956] 'agreement among raft nodes before linearized reading'  (duration: 119.049017ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:39:01.40233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.155388ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:96 size:953032"}
{"level":"info","ts":"2026-05-27T06:39:01.402521Z","caller":"traceutil/trace.go:171","msg":"trace[564059902] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:96; response_revision:17675; }","duration":"129.325391ms","start":"2026-05-27T06:39:01.273084Z","end":"2026-05-27T06:39:01.402409Z","steps":["trace[564059902] 'agreement among raft nodes before linearized reading'  (duration: 120.337362ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:39:26.071763Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15481}
{"level":"info","ts":"2026-05-27T06:39:26.164895Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15481,"took":"89.783308ms","hash":277438098,"current-db-size-bytes":58818560,"current-db-size":"59 MB","current-db-size-in-use-bytes":33304576,"current-db-size-in-use":"33 MB"}
{"level":"info","ts":"2026-05-27T06:39:26.16497Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":277438098,"revision":15481,"compact-revision":12993}
{"level":"info","ts":"2026-05-27T06:42:29.040406Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"4594e5f716bad646","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-05-27T06:42:29.045586Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002}
{"level":"info","ts":"2026-05-27T06:42:29.045876Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002}
{"level":"info","ts":"2026-05-27T06:44:13.813328Z","caller":"traceutil/trace.go:171","msg":"trace[973863828] transaction","detail":"{read_only:false; response_revision:20077; number_of_response:1; }","duration":"207.106026ms","start":"2026-05-27T06:44:13.606194Z","end":"2026-05-27T06:44:13.8133Z","steps":["trace[973863828] 'process raft request'  (duration: 206.936943ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:44:14.040299Z","caller":"traceutil/trace.go:171","msg":"trace[1857006142] transaction","detail":"{read_only:false; response_revision:20078; number_of_response:1; }","duration":"431.248793ms","start":"2026-05-27T06:44:13.609021Z","end":"2026-05-27T06:44:14.04027Z","steps":["trace[1857006142] 'process raft request'  (duration: 337.332986ms)","trace[1857006142] 'compare'  (duration: 93.736623ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-27T06:44:14.040455Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:44:13.608999Z","time spent":"431.380965ms","remote":"127.0.0.1:56252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:20069 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-05-27T06:44:14.040477Z","caller":"traceutil/trace.go:171","msg":"trace[719515229] linearizableReadLoop","detail":"{readStateIndex:20747; appliedIndex:20745; }","duration":"395.106722ms","start":"2026-05-27T06:44:13.645351Z","end":"2026-05-27T06:44:14.040458Z","steps":["trace[719515229] 'read index received'  (duration: 167.810997ms)","trace[719515229] 'applied index is now lower than readState.Index'  (duration: 227.294675ms)"],"step_count":2}
{"level":"info","ts":"2026-05-27T06:44:14.040633Z","caller":"traceutil/trace.go:171","msg":"trace[865406373] transaction","detail":"{read_only:false; response_revision:20079; number_of_response:1; }","duration":"367.559844ms","start":"2026-05-27T06:44:13.67306Z","end":"2026-05-27T06:44:14.04062Z","steps":["trace[865406373] 'process raft request'  (duration: 367.163567ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:44:14.040708Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:44:13.673045Z","time spent":"367.619695ms","remote":"127.0.0.1:56252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:20071 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:465 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-05-27T06:44:14.040882Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.072952ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-27T06:44:14.041014Z","caller":"traceutil/trace.go:171","msg":"trace[93892503] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:20079; }","duration":"369.254577ms","start":"2026-05-27T06:44:13.671737Z","end":"2026-05-27T06:44:14.040991Z","steps":["trace[93892503] 'agreement among raft nodes before linearized reading'  (duration: 369.052232ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:44:14.040927Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"395.588671ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"}
{"level":"warn","ts":"2026-05-27T06:44:14.041086Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:44:13.671711Z","time spent":"369.363778ms","remote":"127.0.0.1:56002","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-05-27T06:44:14.041166Z","caller":"traceutil/trace.go:171","msg":"trace[932981232] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:20079; }","duration":"395.846567ms","start":"2026-05-27T06:44:13.645265Z","end":"2026-05-27T06:44:14.041111Z","steps":["trace[932981232] 'agreement among raft nodes before linearized reading'  (duration: 395.52688ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:44:14.041291Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:44:13.645234Z","time spent":"396.017379ms","remote":"127.0.0.1:56252","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-05-27T06:44:14.516541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.062442ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15440202542147228247 > lease_revoke:<id:56469e6808c4d192>","response":"size:29"}
{"level":"info","ts":"2026-05-27T06:44:15.117677Z","caller":"traceutil/trace.go:171","msg":"trace[1873708793] transaction","detail":"{read_only:false; response_revision:20082; number_of_response:1; }","duration":"207.073346ms","start":"2026-05-27T06:44:14.910577Z","end":"2026-05-27T06:44:15.11765Z","steps":["trace[1873708793] 'process raft request'  (duration: 206.906952ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:44:15.209263Z","caller":"traceutil/trace.go:171","msg":"trace[1254880164] transaction","detail":"{read_only:false; response_revision:20083; number_of_response:1; }","duration":"296.462817ms","start":"2026-05-27T06:44:14.912768Z","end":"2026-05-27T06:44:15.209231Z","steps":["trace[1254880164] 'process raft request'  (duration: 295.398697ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:44:15.209244Z","caller":"traceutil/trace.go:171","msg":"trace[1270877383] linearizableReadLoop","detail":"{readStateIndex:20754; appliedIndex:20751; }","duration":"295.866276ms","start":"2026-05-27T06:44:14.913342Z","end":"2026-05-27T06:44:15.209208Z","steps":["trace[1270877383] 'read index received'  (duration: 204.17388ms)","trace[1270877383] 'applied index is now lower than readState.Index'  (duration: 91.690996ms)"],"step_count":2}
{"level":"info","ts":"2026-05-27T06:44:15.209338Z","caller":"traceutil/trace.go:171","msg":"trace[1705172436] transaction","detail":"{read_only:false; response_revision:20084; number_of_response:1; }","duration":"296.008968ms","start":"2026-05-27T06:44:14.913288Z","end":"2026-05-27T06:44:15.209297Z","steps":["trace[1705172436] 'process raft request'  (duration: 295.833165ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:44:15.209632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.259253ms","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-27T06:44:15.209694Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.358049ms","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-27T06:44:15.209725Z","caller":"traceutil/trace.go:171","msg":"trace[1925846931] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:20084; }","duration":"296.387804ms","start":"2026-05-27T06:44:14.913314Z","end":"2026-05-27T06:44:15.209702Z","steps":["trace[1925846931] 'agreement among raft nodes before linearized reading'  (duration: 296.089609ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:44:15.209782Z","caller":"traceutil/trace.go:171","msg":"trace[1384261209] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/; range_end:/registry/validatingwebhookconfigurations0; response_count:0; response_revision:20084; }","duration":"258.515372ms","start":"2026-05-27T06:44:14.951234Z","end":"2026-05-27T06:44:15.209749Z","steps":["trace[1384261209] 'agreement among raft nodes before linearized reading'  (duration: 258.207527ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:44:26.089771Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":18066}
{"level":"info","ts":"2026-05-27T06:44:26.208807Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":18066,"took":"116.4238ms","hash":942845741,"current-db-size-bytes":58818560,"current-db-size":"59 MB","current-db-size-in-use-bytes":29536256,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-05-27T06:44:26.208878Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":942845741,"revision":18066,"compact-revision":15481}
{"level":"info","ts":"2026-05-27T06:45:03.550804Z","caller":"traceutil/trace.go:171","msg":"trace[123058800] linearizableReadLoop","detail":"{readStateIndex:21314; appliedIndex:21313; }","duration":"110.581251ms","start":"2026-05-27T06:45:03.440181Z","end":"2026-05-27T06:45:03.550763Z","steps":["trace[123058800] 'read index received'  (duration: 80.638948ms)","trace[123058800] 'applied index is now lower than readState.Index'  (duration: 29.940373ms)"],"step_count":2}
{"level":"info","ts":"2026-05-27T06:45:03.550832Z","caller":"traceutil/trace.go:171","msg":"trace[1489963784] transaction","detail":"{read_only:false; response_revision:20623; number_of_response:1; }","duration":"120.231812ms","start":"2026-05-27T06:45:03.43056Z","end":"2026-05-27T06:45:03.550791Z","steps":["trace[1489963784] 'process raft request'  (duration: 90.31597ms)","trace[1489963784] 'compare'  (duration: 29.606757ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-27T06:45:03.550973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.784044ms","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-27T06:45:03.551063Z","caller":"traceutil/trace.go:171","msg":"trace[1161407142] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:20623; }","duration":"110.911366ms","start":"2026-05-27T06:45:03.440136Z","end":"2026-05-27T06:45:03.551047Z","steps":["trace[1161407142] 'agreement among raft nodes before linearized reading'  (duration: 110.723662ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:45:03.55114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.659492ms","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-27T06:45:03.551183Z","caller":"traceutil/trace.go:171","msg":"trace[1493859489] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:20623; }","duration":"110.741954ms","start":"2026-05-27T06:45:03.440431Z","end":"2026-05-27T06:45:03.551173Z","steps":["trace[1493859489] 'agreement among raft nodes before linearized reading'  (duration: 110.541479ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:48:02.939669Z","caller":"traceutil/trace.go:171","msg":"trace[951247924] transaction","detail":"{read_only:false; response_revision:22496; number_of_response:1; }","duration":"170.910005ms","start":"2026-05-27T06:48:02.768731Z","end":"2026-05-27T06:48:02.939641Z","steps":["trace[951247924] 'process raft request'  (duration: 170.691891ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:48:03.2507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.645504ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15440202542147235332 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:22459 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-27T06:48:03.251007Z","caller":"traceutil/trace.go:171","msg":"trace[1326287307] transaction","detail":"{read_only:false; response_revision:22499; number_of_response:1; }","duration":"406.872083ms","start":"2026-05-27T06:48:02.844112Z","end":"2026-05-27T06:48:03.250984Z","steps":["trace[1326287307] 'process raft request'  (duration: 406.807092ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:48:03.251016Z","caller":"traceutil/trace.go:171","msg":"trace[1398163031] transaction","detail":"{read_only:false; response_revision:22497; number_of_response:1; }","duration":"408.26664ms","start":"2026-05-27T06:48:02.842713Z","end":"2026-05-27T06:48:03.250979Z","steps":["trace[1398163031] 'process raft request'  (duration: 248.178679ms)","trace[1398163031] 'compare'  (duration: 159.436609ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-27T06:48:03.251093Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:48:02.844099Z","time spent":"406.957324ms","remote":"127.0.0.1:56252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/capo-system/controller-leader-election-capo\" mod_revision:22458 > 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-27T06:48:03.25118Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:48:02.842664Z","time spent":"408.430012ms","remote":"127.0.0.1:56252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:22459 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-05-27T06:48:03.251283Z","caller":"traceutil/trace.go:171","msg":"trace[59732076] transaction","detail":"{read_only:false; response_revision:22498; number_of_response:1; }","duration":"408.517236ms","start":"2026-05-27T06:48:02.842714Z","end":"2026-05-27T06:48:03.251231Z","steps":["trace[59732076] 'process raft request'  (duration: 408.106017ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:48:03.251451Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:48:02.842691Z","time spent":"408.674958ms","remote":"127.0.0.1:56252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:22460 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:465 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"info","ts":"2026-05-27T06:49:26.097418Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":20141}
{"level":"info","ts":"2026-05-27T06:49:26.211204Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":20141,"took":"109.893527ms","hash":2176002679,"current-db-size-bytes":58818560,"current-db-size":"59 MB","current-db-size-in-use-bytes":41877504,"current-db-size-in-use":"42 MB"}
{"level":"info","ts":"2026-05-27T06:49:26.211258Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2176002679,"revision":20141,"compact-revision":18066}
{"level":"info","ts":"2026-05-27T06:51:15.388817Z","caller":"traceutil/trace.go:171","msg":"trace[964092587] transaction","detail":"{read_only:false; response_revision:24487; number_of_response:1; }","duration":"107.089578ms","start":"2026-05-27T06:51:15.281707Z","end":"2026-05-27T06:51:15.388797Z","steps":["trace[964092587] 'process raft request'  (duration: 106.940666ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:51:15.684127Z","caller":"traceutil/trace.go:171","msg":"trace[1202865768] linearizableReadLoop","detail":"{readStateIndex:25280; appliedIndex:25278; }","duration":"353.884196ms","start":"2026-05-27T06:51:15.330217Z","end":"2026-05-27T06:51:15.684101Z","steps":["trace[1202865768] 'read index received'  (duration: 58.455942ms)","trace[1202865768] 'applied index is now lower than readState.Index'  (duration: 295.427354ms)"],"step_count":2}
{"level":"info","ts":"2026-05-27T06:51:15.684226Z","caller":"traceutil/trace.go:171","msg":"trace[688035708] transaction","detail":"{read_only:false; response_revision:24488; number_of_response:1; }","duration":"401.681187ms","start":"2026-05-27T06:51:15.282536Z","end":"2026-05-27T06:51:15.684217Z","steps":["trace[688035708] 'process raft request'  (duration: 398.378744ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:51:15.684299Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:51:15.282525Z","time spent":"401.715937ms","remote":"127.0.0.1:56252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:24473 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-05-27T06:51:15.684407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.211272ms","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-27T06:51:15.684427Z","caller":"traceutil/trace.go:171","msg":"trace[1299253285] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:24488; }","duration":"354.232482ms","start":"2026-05-27T06:51:15.330188Z","end":"2026-05-27T06:51:15.684421Z","steps":["trace[1299253285] 'agreement among raft nodes before linearized reading'  (duration: 354.186491ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:51:15.684445Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:51:15.330122Z","time spent":"354.318604ms","remote":"127.0.0.1:56288","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":18,"response size":31,"request content":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true "}
{"level":"warn","ts":"2026-05-27T06:51:15.684426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.249049ms","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-27T06:51:15.684477Z","caller":"traceutil/trace.go:171","msg":"trace[577162980] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24488; }","duration":"305.344151ms","start":"2026-05-27T06:51:15.379121Z","end":"2026-05-27T06:51:15.684466Z","steps":["trace[577162980] 'agreement among raft nodes before linearized reading'  (duration: 305.211399ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:51:15.6845Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:51:15.379103Z","time spent":"305.392482ms","remote":"127.0.0.1:56252","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":532,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-05-27T06:51:15.684589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.11131ms","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-27T06:51:15.684605Z","caller":"traceutil/trace.go:171","msg":"trace[807924136] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24488; }","duration":"268.148692ms","start":"2026-05-27T06:51:15.416453Z","end":"2026-05-27T06:51:15.684601Z","steps":["trace[807924136] 'agreement among raft nodes before linearized reading'  (duration: 268.107501ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:51:15.684799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.004613ms","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-27T06:51:15.684818Z","caller":"traceutil/trace.go:171","msg":"trace[1409493914] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24488; }","duration":"272.064154ms","start":"2026-05-27T06:51:15.412749Z","end":"2026-05-27T06:51:15.684813Z","steps":["trace[1409493914] 'agreement among raft nodes before linearized reading'  (duration: 271.888071ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:51:15.84357Z","caller":"traceutil/trace.go:171","msg":"trace[1672271270] transaction","detail":"{read_only:false; response_revision:24492; number_of_response:1; }","duration":"107.184709ms","start":"2026-05-27T06:51:15.736339Z","end":"2026-05-27T06:51:15.843524Z","steps":["trace[1672271270] 'process raft request'  (duration: 106.910194ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:51:20.014113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.437676ms","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-27T06:51:20.014194Z","caller":"traceutil/trace.go:171","msg":"trace[1445777052] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24521; }","duration":"216.571889ms","start":"2026-05-27T06:51:19.797605Z","end":"2026-05-27T06:51:20.014177Z","steps":["trace[1445777052] 'range keys from in-memory index tree'  (duration: 216.227392ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:51:20.014372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.514728ms","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-27T06:51:20.01452Z","caller":"traceutil/trace.go:171","msg":"trace[292024531] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24521; }","duration":"216.855834ms","start":"2026-05-27T06:51:19.797639Z","end":"2026-05-27T06:51:20.014495Z","steps":["trace[292024531] 'range keys from in-memory index tree'  (duration: 216.298693ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:51:20.281116Z","caller":"traceutil/trace.go:171","msg":"trace[1960344129] transaction","detail":"{read_only:false; response_revision:24523; number_of_response:1; }","duration":"322.75999ms","start":"2026-05-27T06:51:19.958327Z","end":"2026-05-27T06:51:20.281087Z","steps":["trace[1960344129] 'process raft request'  (duration: 234.308104ms)","trace[1960344129] 'compare'  (duration: 88.296023ms)"],"step_count":2}
{"level":"info","ts":"2026-05-27T06:51:20.281405Z","caller":"traceutil/trace.go:171","msg":"trace[246388718] transaction","detail":"{read_only:false; response_revision:24524; number_of_response:1; }","duration":"322.940213ms","start":"2026-05-27T06:51:19.958434Z","end":"2026-05-27T06:51:20.281374Z","steps":["trace[246388718] 'process raft request'  (duration: 322.608747ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:51:20.281566Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:51:19.958414Z","time spent":"323.068986ms","remote":"127.0.0.1:56252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":497,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:24510 > success:<request_put:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" value_size:441 >> failure:<request_range:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" > >"}
{"level":"info","ts":"2026-05-27T06:51:20.281617Z","caller":"traceutil/trace.go:171","msg":"trace[1930377790] transaction","detail":"{read_only:false; response_revision:24525; number_of_response:1; }","duration":"263.022985ms","start":"2026-05-27T06:51:20.018573Z","end":"2026-05-27T06:51:20.281596Z","steps":["trace[1930377790] 'process raft request'  (duration: 262.711219ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:51:20.281471Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:51:19.958301Z","time spent":"322.897153ms","remote":"127.0.0.1:56252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:24511 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-05-27T06:51:20.281835Z","caller":"traceutil/trace.go:171","msg":"trace[231857956] transaction","detail":"{read_only:false; response_revision:24526; number_of_response:1; }","duration":"262.407092ms","start":"2026-05-27T06:51:20.01941Z","end":"2026-05-27T06:51:20.281817Z","steps":["trace[231857956] 'process raft request'  (duration: 262.125647ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:51:20.281869Z","caller":"traceutil/trace.go:171","msg":"trace[475690529] transaction","detail":"{read_only:false; response_revision:24527; number_of_response:1; }","duration":"170.203105ms","start":"2026-05-27T06:51:20.111639Z","end":"2026-05-27T06:51:20.281842Z","steps":["trace[475690529] 'process raft request'  (duration: 170.152704ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:51:20.28198Z","caller":"traceutil/trace.go:171","msg":"trace[644131174] linearizableReadLoop","detail":"{readStateIndex:25319; appliedIndex:25315; }","duration":"226.750851ms","start":"2026-05-27T06:51:20.055178Z","end":"2026-05-27T06:51:20.281928Z","steps":["trace[644131174] 'read index received'  (duration: 137.43937ms)","trace[644131174] 'applied index is now lower than readState.Index'  (duration: 89.305111ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-27T06:51:20.282071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.888074ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-05-27T06:51:20.282123Z","caller":"traceutil/trace.go:171","msg":"trace[166507659] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:24527; }","duration":"226.940895ms","start":"2026-05-27T06:51:20.055165Z","end":"2026-05-27T06:51:20.282106Z","steps":["trace[166507659] 'agreement among raft nodes before linearized reading'  (duration: 226.817382ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:51:20.346183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.746606ms","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-27T06:51:20.346266Z","caller":"traceutil/trace.go:171","msg":"trace[1199611476] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24528; }","duration":"204.880909ms","start":"2026-05-27T06:51:20.141367Z","end":"2026-05-27T06:51:20.346248Z","steps":["trace[1199611476] 'agreement among raft nodes before linearized reading'  (duration: 204.646864ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:51:20.346591Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.57681ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/podmonitors/\" range_end:\"/registry/monitoring.coreos.com/podmonitors0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-05-27T06:51:20.34669Z","caller":"traceutil/trace.go:171","msg":"trace[1112843649] range","detail":"{range_begin:/registry/monitoring.coreos.com/podmonitors/; range_end:/registry/monitoring.coreos.com/podmonitors0; response_count:0; response_revision:24528; }","duration":"164.704403ms","start":"2026-05-27T06:51:20.181948Z","end":"2026-05-27T06:51:20.346653Z","steps":["trace[1112843649] 'agreement among raft nodes before linearized reading'  (duration: 164.52056ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:51:20.346655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.216939ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ipam.cluster.x-k8s.io/ipaddressclaims/\" range_end:\"/registry/ipam.cluster.x-k8s.io/ipaddressclaims0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-27T06:51:20.346768Z","caller":"traceutil/trace.go:171","msg":"trace[1097029519] range","detail":"{range_begin:/registry/ipam.cluster.x-k8s.io/ipaddressclaims/; range_end:/registry/ipam.cluster.x-k8s.io/ipaddressclaims0; response_count:0; response_revision:24528; }","duration":"202.381453ms","start":"2026-05-27T06:51:20.144363Z","end":"2026-05-27T06:51:20.346745Z","steps":["trace[1097029519] 'agreement among raft nodes before linearized reading'  (duration: 202.152499ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:51:21.166354Z","caller":"traceutil/trace.go:171","msg":"trace[1542258935] linearizableReadLoop","detail":"{readStateIndex:25324; appliedIndex:25323; }","duration":"228.33431ms","start":"2026-05-27T06:51:20.937989Z","end":"2026-05-27T06:51:21.166323Z","steps":["trace[1542258935] 'read index received'  (duration: 228.231429ms)","trace[1542258935] 'applied index is now lower than readState.Index'  (duration: 101.571µs)"],"step_count":2}
{"level":"info","ts":"2026-05-27T06:51:21.16646Z","caller":"traceutil/trace.go:171","msg":"trace[870217774] transaction","detail":"{read_only:false; response_revision:24531; number_of_response:1; }","duration":"315.990952ms","start":"2026-05-27T06:51:20.85043Z","end":"2026-05-27T06:51:21.166421Z","steps":["trace[870217774] 'process raft request'  (duration: 315.718167ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:51:21.166578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.576276ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12217"}
{"level":"info","ts":"2026-05-27T06:51:21.166614Z","caller":"traceutil/trace.go:171","msg":"trace[1780308074] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:24531; }","duration":"228.668047ms","start":"2026-05-27T06:51:20.937936Z","end":"2026-05-27T06:51:21.166604Z","steps":["trace[1780308074] 'agreement among raft nodes before linearized reading'  (duration: 228.498654ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:51:21.166622Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:51:20.850403Z","time spent":"316.127344ms","remote":"127.0.0.1:56252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":627,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" mod_revision:24492 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" value_size:518 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" > >"}
{"level":"info","ts":"2026-05-27T06:51:21.270874Z","caller":"traceutil/trace.go:171","msg":"trace[1897982462] linearizableReadLoop","detail":"{readStateIndex:25325; appliedIndex:25324; }","duration":"101.986721ms","start":"2026-05-27T06:51:21.168869Z","end":"2026-05-27T06:51:21.270856Z","steps":["trace[1897982462] 'read index received'  (duration: 100.88622ms)","trace[1897982462] 'applied index is now lower than readState.Index'  (duration: 1.099671ms)"],"step_count":2}
{"level":"info","ts":"2026-05-27T06:51:21.27099Z","caller":"traceutil/trace.go:171","msg":"trace[1753643177] transaction","detail":"{read_only:false; response_revision:24532; number_of_response:1; }","duration":"164.08312ms","start":"2026-05-27T06:51:21.106833Z","end":"2026-05-27T06:51:21.270916Z","steps":["trace[1753643177] 'process raft request'  (duration: 162.913218ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:51:21.271027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.127923ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/addons.cluster.x-k8s.io/clusterresourcesetbindings/\" range_end:\"/registry/addons.cluster.x-k8s.io/clusterresourcesetbindings0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-05-27T06:51:21.271347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.293048ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12217"}
{"level":"info","ts":"2026-05-27T06:51:21.271396Z","caller":"traceutil/trace.go:171","msg":"trace[1957109490] range","detail":"{range_begin:/registry/addons.cluster.x-k8s.io/clusterresourcesetbindings/; range_end:/registry/addons.cluster.x-k8s.io/clusterresourcesetbindings0; response_count:0; response_revision:24532; }","duration":"102.533701ms","start":"2026-05-27T06:51:21.168838Z","end":"2026-05-27T06:51:21.271372Z","steps":["trace[1957109490] 'agreement among raft nodes before linearized reading'  (duration: 102.105064ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:51:21.271128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.368091ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/\" range_end:\"/registry/cert-manager.io/certificates0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-05-27T06:51:21.27142Z","caller":"traceutil/trace.go:171","msg":"trace[537674375] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:24532; }","duration":"101.373349ms","start":"2026-05-27T06:51:21.170038Z","end":"2026-05-27T06:51:21.271411Z","steps":["trace[537674375] 'agreement among raft nodes before linearized reading'  (duration: 100.920371ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:51:21.271713Z","caller":"traceutil/trace.go:171","msg":"trace[1576118594] range","detail":"{range_begin:/registry/cert-manager.io/certificates/; range_end:/registry/cert-manager.io/certificates0; response_count:0; response_revision:24532; }","duration":"100.808279ms","start":"2026-05-27T06:51:21.170657Z","end":"2026-05-27T06:51:21.271466Z","steps":["trace[1576118594] 'agreement among raft nodes before linearized reading'  (duration: 100.377771ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:51:21.61999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.942192ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15440202542147240074 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/ingress/openstack/container-infra\" mod_revision:24300 > success:<request_put:<key:\"/registry/ingress/openstack/container-infra\" value_size:818 >> failure:<request_range:<key:\"/registry/ingress/openstack/container-infra\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-27T06:51:21.620266Z","caller":"traceutil/trace.go:171","msg":"trace[451467669] transaction","detail":"{read_only:false; response_revision:24533; number_of_response:1; }","duration":"340.721367ms","start":"2026-05-27T06:51:21.279521Z","end":"2026-05-27T06:51:21.620242Z","steps":["trace[451467669] 'process raft request'  (duration: 136.446149ms)","trace[451467669] 'compare'  (duration: 203.82658ms)"],"step_count":2}
{"level":"info","ts":"2026-05-27T06:51:21.620286Z","caller":"traceutil/trace.go:171","msg":"trace[492940315] linearizableReadLoop","detail":"{readStateIndex:25327; appliedIndex:25325; }","duration":"259.801283ms","start":"2026-05-27T06:51:21.360471Z","end":"2026-05-27T06:51:21.620272Z","steps":["trace[492940315] 'read index received'  (duration: 55.508715ms)","trace[492940315] 'applied index is now lower than readState.Index'  (duration: 204.291728ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-27T06:51:21.620357Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:51:21.279503Z","time spent":"340.802488ms","remote":"127.0.0.1:56288","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":869,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/ingress/openstack/container-infra\" mod_revision:24300 > success:<request_put:<key:\"/registry/ingress/openstack/container-infra\" value_size:818 >> failure:<request_range:<key:\"/registry/ingress/openstack/container-infra\" > >"}
{"level":"info","ts":"2026-05-27T06:51:21.62055Z","caller":"traceutil/trace.go:171","msg":"trace[648249105] transaction","detail":"{read_only:false; response_revision:24534; number_of_response:1; }","duration":"340.571005ms","start":"2026-05-27T06:51:21.279967Z","end":"2026-05-27T06:51:21.620538Z","steps":["trace[648249105] 'process raft request'  (duration: 340.206778ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:51:21.620598Z","caller":"traceutil/trace.go:171","msg":"trace[166800074] transaction","detail":"{read_only:false; response_revision:24535; number_of_response:1; }","duration":"217.253353ms","start":"2026-05-27T06:51:21.403333Z","end":"2026-05-27T06:51:21.620587Z","steps":["trace[166800074] 'process raft request'  (duration: 216.898896ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:51:21.620626Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:51:21.279928Z","time spent":"340.661708ms","remote":"127.0.0.1:56288","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":924,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/ingress/openstack/container-infra-registry\" mod_revision:24377 > success:<request_put:<key:\"/registry/ingress/openstack/container-infra-registry\" value_size:864 >> failure:<request_range:<key:\"/registry/ingress/openstack/container-infra-registry\" > >"}
{"level":"warn","ts":"2026-05-27T06:51:21.62071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.231961ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-05-27T06:51:21.620711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.197642ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-05-27T06:51:21.620752Z","caller":"traceutil/trace.go:171","msg":"trace[494357717] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:24535; }","duration":"260.277572ms","start":"2026-05-27T06:51:21.360461Z","end":"2026-05-27T06:51:21.620738Z","steps":["trace[494357717] 'agreement among raft nodes before linearized reading'  (duration: 260.201811ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:51:21.620763Z","caller":"traceutil/trace.go:171","msg":"trace[660447920] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:24535; }","duration":"217.266823ms","start":"2026-05-27T06:51:21.403483Z","end":"2026-05-27T06:51:21.62075Z","steps":["trace[660447920] 'agreement among raft nodes before linearized reading'  (duration: 217.106631ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:51:21.913744Z","caller":"traceutil/trace.go:171","msg":"trace[164573761] linearizableReadLoop","detail":"{readStateIndex:25329; appliedIndex:25328; }","duration":"284.876146ms","start":"2026-05-27T06:51:21.628846Z","end":"2026-05-27T06:51:21.913722Z","steps":["trace[164573761] 'read index received'  (duration: 284.659572ms)","trace[164573761] 'applied index is now lower than readState.Index'  (duration: 215.924µs)"],"step_count":2}
{"level":"info","ts":"2026-05-27T06:51:21.91386Z","caller":"traceutil/trace.go:171","msg":"trace[371085593] transaction","detail":"{read_only:false; response_revision:24536; number_of_response:1; }","duration":"285.62254ms","start":"2026-05-27T06:51:21.628218Z","end":"2026-05-27T06:51:21.91384Z","steps":["trace[371085593] 'process raft request'  (duration: 285.343604ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:51:21.91396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.0955ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12217"}
{"level":"info","ts":"2026-05-27T06:51:21.913992Z","caller":"traceutil/trace.go:171","msg":"trace[734598552] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:24536; }","duration":"285.169181ms","start":"2026-05-27T06:51:21.628814Z","end":"2026-05-27T06:51:21.913983Z","steps":["trace[734598552] 'agreement among raft nodes before linearized reading'  (duration: 285.014918ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:51:21.914083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.290556ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates/\" range_end:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-05-27T06:51:21.91419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.422893ms","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-27T06:51:21.914234Z","caller":"traceutil/trace.go:171","msg":"trace[902456625] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24536; }","duration":"193.466933ms","start":"2026-05-27T06:51:21.720754Z","end":"2026-05-27T06:51:21.914221Z","steps":["trace[902456625] 'agreement among raft nodes before linearized reading'  (duration: 193.328231ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:51:21.914272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.305226ms","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-27T06:51:21.914324Z","caller":"traceutil/trace.go:171","msg":"trace[704305958] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24536; }","duration":"197.415968ms","start":"2026-05-27T06:51:21.716888Z","end":"2026-05-27T06:51:21.914304Z","steps":["trace[704305958] 'agreement among raft nodes before linearized reading'  (duration: 197.264055ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:51:21.914097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.327446ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-27T06:51:21.914465Z","caller":"traceutil/trace.go:171","msg":"trace[95753574] range","detail":"{range_begin:/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates/; range_end:/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates0; response_count:0; response_revision:24536; }","duration":"102.421929ms","start":"2026-05-27T06:51:21.811731Z","end":"2026-05-27T06:51:21.914153Z","steps":["trace[95753574] 'agreement among raft nodes before linearized reading'  (duration: 102.269736ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:51:21.914489Z","caller":"traceutil/trace.go:171","msg":"trace[1072895322] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24536; }","duration":"241.764893ms","start":"2026-05-27T06:51:21.672708Z","end":"2026-05-27T06:51:21.914473Z","steps":["trace[1072895322] 'agreement among raft nodes before linearized reading'  (duration: 241.286874ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:51:22.040294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.852916ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/container-infra-registry.18b3597b9b8a5652\" ","response":"range_response_count:1 size:722"}
{"level":"info","ts":"2026-05-27T06:51:22.04038Z","caller":"traceutil/trace.go:171","msg":"trace[1398380014] range","detail":"{range_begin:/registry/events/openstack/container-infra-registry.18b3597b9b8a5652; range_end:; response_count:1; response_revision:24536; }","duration":"121.968757ms","start":"2026-05-27T06:51:21.918391Z","end":"2026-05-27T06:51:22.040359Z","steps":["trace[1398380014] 'range keys from in-memory index tree'  (duration: 121.663722ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:51:22.040387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.921194ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-05-27T06:51:22.040443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.004236ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:18624"}
{"level":"info","ts":"2026-05-27T06:51:22.040462Z","caller":"traceutil/trace.go:171","msg":"trace[352197316] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24536; }","duration":"124.034576ms","start":"2026-05-27T06:51:21.916408Z","end":"2026-05-27T06:51:22.040443Z","steps":["trace[352197316] 'range keys from in-memory index tree'  (duration: 123.835622ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:51:22.040443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.711741ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-4c8f5c0f-0044-4323-a5cb-aa1d2b5f53f8\" ","response":"range_response_count:1 size:1322"}
{"level":"info","ts":"2026-05-27T06:51:22.040505Z","caller":"traceutil/trace.go:171","msg":"trace[1083906028] range","detail":"{range_begin:/registry/persistentvolumes/pvc-4c8f5c0f-0044-4323-a5cb-aa1d2b5f53f8; range_end:; response_count:1; response_revision:24536; }","duration":"122.800233ms","start":"2026-05-27T06:51:21.917694Z","end":"2026-05-27T06:51:22.040495Z","steps":["trace[1083906028] 'range keys from in-memory index tree'  (duration: 122.615399ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:51:22.040503Z","caller":"traceutil/trace.go:171","msg":"trace[371594641] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:24536; }","duration":"124.062807ms","start":"2026-05-27T06:51:21.916424Z","end":"2026-05-27T06:51:22.040486Z","steps":["trace[371594641] 'range keys from in-memory index tree'  (duration: 123.866643ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:51:22.040548Z","caller":"traceutil/trace.go:171","msg":"trace[2089849100] transaction","detail":"{read_only:false; response_revision:24537; number_of_response:1; }","duration":"121.874215ms","start":"2026-05-27T06:51:21.918652Z","end":"2026-05-27T06:51:22.040526Z","steps":["trace[2089849100] 'process raft request'  (duration: 35.727184ms)","trace[2089849100] 'compare'  (duration: 85.846976ms)"],"step_count":2}
{"level":"info","ts":"2026-05-27T06:51:22.040738Z","caller":"traceutil/trace.go:171","msg":"trace[1700637106] transaction","detail":"{read_only:false; response_revision:24538; number_of_response:1; }","duration":"121.876056ms","start":"2026-05-27T06:51:21.918847Z","end":"2026-05-27T06:51:22.040723Z","steps":["trace[1700637106] 'process raft request'  (duration: 121.61937ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:51:22.294296Z","caller":"traceutil/trace.go:171","msg":"trace[731382108] linearizableReadLoop","detail":"{readStateIndex:25333; appliedIndex:25332; }","duration":"238.544984ms","start":"2026-05-27T06:51:22.055731Z","end":"2026-05-27T06:51:22.294277Z","steps":["trace[731382108] 'read index received'  (duration: 202.645547ms)","trace[731382108] 'applied index is now lower than readState.Index'  (duration: 35.898177ms)"],"step_count":2}
{"level":"info","ts":"2026-05-27T06:51:22.29431Z","caller":"traceutil/trace.go:171","msg":"trace[2007200426] transaction","detail":"{read_only:false; response_revision:24540; number_of_response:1; }","duration":"249.393447ms","start":"2026-05-27T06:51:22.044895Z","end":"2026-05-27T06:51:22.294288Z","steps":["trace[2007200426] 'process raft request'  (duration: 213.870857ms)","trace[2007200426] 'compare'  (duration: 35.304466ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-27T06:51:22.294464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.721157ms","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-27T06:51:22.294499Z","caller":"traceutil/trace.go:171","msg":"trace[1958000952] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:24540; }","duration":"238.795559ms","start":"2026-05-27T06:51:22.055691Z","end":"2026-05-27T06:51:22.294486Z","steps":["trace[1958000952] 'agreement among raft nodes before linearized reading'  (duration: 238.671886ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:51:22.322402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.023452ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-27T06:51:22.322465Z","caller":"traceutil/trace.go:171","msg":"trace[1793605251] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0; response_count:0; response_revision:24543; }","duration":"240.115023ms","start":"2026-05-27T06:51:22.082334Z","end":"2026-05-27T06:51:22.322449Z","steps":["trace[1793605251] 'agreement among raft nodes before linearized reading'  (duration: 240.001461ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:51:22.323189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.233335ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:9"}
{"level":"info","ts":"2026-05-27T06:51:22.323265Z","caller":"traceutil/trace.go:171","msg":"trace[215844512] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:24543; }","duration":"102.354868ms","start":"2026-05-27T06:51:22.220895Z","end":"2026-05-27T06:51:22.32325Z","steps":["trace[215844512] 'agreement among raft nodes before linearized reading'  (duration: 101.613424ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:51:22.605178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.660252ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15440202542147240097 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:24526 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-27T06:51:22.605252Z","caller":"traceutil/trace.go:171","msg":"trace[439573512] transaction","detail":"{read_only:false; response_revision:24544; number_of_response:1; }","duration":"279.148959ms","start":"2026-05-27T06:51:22.326091Z","end":"2026-05-27T06:51:22.60524Z","steps":["trace[439573512] 'process raft request'  (duration: 115.363744ms)","trace[439573512] 'compare'  (duration: 163.03003ms)"],"step_count":2}
{"level":"info","ts":"2026-05-27T06:51:22.67054Z","caller":"traceutil/trace.go:171","msg":"trace[819891386] linearizableReadLoop","detail":"{readStateIndex:25338; appliedIndex:25336; }","duration":"342.94988ms","start":"2026-05-27T06:51:22.327567Z","end":"2026-05-27T06:51:22.670517Z","steps":["trace[819891386] 'read index received'  (duration: 113.899756ms)","trace[819891386] 'applied index is now lower than readState.Index'  (duration: 229.048754ms)"],"step_count":2}
{"level":"info","ts":"2026-05-27T06:51:22.670595Z","caller":"traceutil/trace.go:171","msg":"trace[2092934600] transaction","detail":"{read_only:false; response_revision:24545; number_of_response:1; }","duration":"344.005329ms","start":"2026-05-27T06:51:22.326552Z","end":"2026-05-27T06:51:22.670557Z","steps":["trace[2092934600] 'process raft request'  (duration: 343.776045ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:51:22.670643Z","caller":"traceutil/trace.go:171","msg":"trace[1041785562] transaction","detail":"{read_only:false; response_revision:24546; number_of_response:1; }","duration":"319.08939ms","start":"2026-05-27T06:51:22.351523Z","end":"2026-05-27T06:51:22.670612Z","steps":["trace[1041785562] 'process raft request'  (duration: 318.947467ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:51:22.670761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.167955ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/magnum-system/\" range_end:\"/registry/services/specs/magnum-system0\" ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-05-27T06:51:22.670783Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:51:22.351504Z","time spent":"319.213213ms","remote":"127.0.0.1:56252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/capi-system/controller-leader-election-capi\" mod_revision:24528 > 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-27T06:51:22.670782Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:51:22.32653Z","time spent":"344.161783ms","remote":"127.0.0.1:56252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:24525 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-05-27T06:51:22.670818Z","caller":"traceutil/trace.go:171","msg":"trace[359906837] range","detail":"{range_begin:/registry/services/specs/magnum-system/; range_end:/registry/services/specs/magnum-system0; response_count:0; response_revision:24546; }","duration":"343.264336ms","start":"2026-05-27T06:51:22.327539Z","end":"2026-05-27T06:51:22.670803Z","steps":["trace[359906837] 'agreement among raft nodes before linearized reading'  (duration: 343.089492ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:51:22.670863Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:51:22.327524Z","time spent":"343.330498ms","remote":"127.0.0.1:56190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":29,"request content":"key:\"/registry/services/specs/magnum-system/\" range_end:\"/registry/services/specs/magnum-system0\" "}
{"level":"info","ts":"2026-05-27T06:51:22.929102Z","caller":"traceutil/trace.go:171","msg":"trace[61142355] linearizableReadLoop","detail":"{readStateIndex:25340; appliedIndex:25339; }","duration":"258.473448ms","start":"2026-05-27T06:51:22.670601Z","end":"2026-05-27T06:51:22.929075Z","steps":["trace[61142355] 'read index received'  (duration: 184.383783ms)","trace[61142355] 'applied index is now lower than readState.Index'  (duration: 74.088285ms)"],"step_count":2}
{"level":"info","ts":"2026-05-27T06:51:22.929126Z","caller":"traceutil/trace.go:171","msg":"trace[352227832] transaction","detail":"{read_only:false; response_revision:24547; number_of_response:1; }","duration":"459.185419ms","start":"2026-05-27T06:51:22.469905Z","end":"2026-05-27T06:51:22.92909Z","steps":["trace[352227832] 'process raft request'  (duration: 385.138234ms)","trace[352227832] 'compare'  (duration: 73.900432ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-27T06:51:22.929209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"451.407352ms","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-27T06:51:22.92928Z","caller":"traceutil/trace.go:171","msg":"trace[1925299297] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:24547; }","duration":"451.528085ms","start":"2026-05-27T06:51:22.477732Z","end":"2026-05-27T06:51:22.92926Z","steps":["trace[1925299297] 'agreement among raft nodes before linearized reading'  (duration: 451.363452ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:51:22.929297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.361762ms","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":"warn","ts":"2026-05-27T06:51:22.929303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.968874ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/machinesets/\" range_end:\"/registry/cluster.x-k8s.io/machinesets0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-05-27T06:51:22.929344Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:51:22.477719Z","time spent":"451.610266ms","remote":"127.0.0.1:33660","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":31,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "}
{"level":"warn","ts":"2026-05-27T06:51:22.929345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.164055ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/users/\" range_end:\"/registry/rabbitmq.com/users0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-05-27T06:51:22.929296Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:51:22.469879Z","time spent":"459.319812ms","remote":"127.0.0.1:56252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/capo-system/controller-leader-election-capo\" mod_revision:24530 > 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":"info","ts":"2026-05-27T06:51:22.929423Z","caller":"traceutil/trace.go:171","msg":"trace[1279573557] range","detail":"{range_begin:/registry/rabbitmq.com/users/; range_end:/registry/rabbitmq.com/users0; response_count:0; response_revision:24547; }","duration":"230.270927ms","start":"2026-05-27T06:51:22.699128Z","end":"2026-05-27T06:51:22.929399Z","steps":["trace[1279573557] 'agreement among raft nodes before linearized reading'  (duration: 230.163605ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:51:22.929463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"533.391527ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectzonegroups/\" range_end:\"/registry/ceph.rook.io/cephobjectzonegroups0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-27T06:51:22.929497Z","caller":"traceutil/trace.go:171","msg":"trace[1622844439] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectzonegroups/; range_end:/registry/ceph.rook.io/cephobjectzonegroups0; response_count:0; response_revision:24547; }","duration":"533.461548ms","start":"2026-05-27T06:51:22.396025Z","end":"2026-05-27T06:51:22.929486Z","steps":["trace[1622844439] 'agreement among raft nodes before linearized reading'  (duration: 533.142232ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:51:22.929398Z","caller":"traceutil/trace.go:171","msg":"trace[584717449] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machinesets/; range_end:/registry/cluster.x-k8s.io/machinesets0; response_count:0; response_revision:24547; }","duration":"168.102507ms","start":"2026-05-27T06:51:22.761267Z","end":"2026-05-27T06:51:22.929369Z","steps":["trace[584717449] 'agreement among raft nodes before linearized reading'  (duration: 167.978225ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:51:22.929533Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:51:22.396009Z","time spent":"533.51496ms","remote":"127.0.0.1:33280","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":29,"request content":"key:\"/registry/ceph.rook.io/cephobjectzonegroups/\" range_end:\"/registry/ceph.rook.io/cephobjectzonegroups0\" count_only:true "}
{"level":"info","ts":"2026-05-27T06:51:22.92934Z","caller":"traceutil/trace.go:171","msg":"trace[644656778] range","detail":"{range_begin:/registry/endpointslices/magnum-system/; range_end:/registry/endpointslices/magnum-system0; response_count:0; response_revision:24547; }","duration":"253.454734ms","start":"2026-05-27T06:51:22.675873Z","end":"2026-05-27T06:51:22.929328Z","steps":["trace[644656778] 'agreement among raft nodes before linearized reading'  (duration: 253.362822ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:51:22.929639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"497.772426ms","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-27T06:51:22.929737Z","caller":"traceutil/trace.go:171","msg":"trace[1977771822] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24547; }","duration":"497.95665ms","start":"2026-05-27T06:51:22.431761Z","end":"2026-05-27T06:51:22.929718Z","steps":["trace[1977771822] 'agreement among raft nodes before linearized reading'  (duration: 497.397279ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:51:22.929779Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:51:22.4317Z","time spent":"498.068372ms","remote":"127.0.0.1:56252","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-05-27T06:51:23.401842Z","caller":"traceutil/trace.go:171","msg":"trace[1132453993] transaction","detail":"{read_only:false; response_revision:24549; number_of_response:1; }","duration":"125.142538ms","start":"2026-05-27T06:51:23.27667Z","end":"2026-05-27T06:51:23.401813Z","steps":["trace[1132453993] 'process raft request'  (duration: 124.928494ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:51:24.349645Z","caller":"traceutil/trace.go:171","msg":"trace[739581335] transaction","detail":"{read_only:false; response_revision:24551; number_of_response:1; }","duration":"302.788144ms","start":"2026-05-27T06:51:24.046832Z","end":"2026-05-27T06:51:24.34962Z","steps":["trace[739581335] 'process raft request'  (duration: 302.618111ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:51:24.349927Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:51:24.046811Z","time spent":"302.920996ms","remote":"127.0.0.1:56252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:24539 > 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-27T06:51:24.350569Z","caller":"traceutil/trace.go:171","msg":"trace[1167476857] linearizableReadLoop","detail":"{readStateIndex:25344; appliedIndex:25344; }","duration":"303.607869ms","start":"2026-05-27T06:51:24.046947Z","end":"2026-05-27T06:51:24.350555Z","steps":["trace[1167476857] 'read index received'  (duration: 303.602369ms)","trace[1167476857] 'applied index is now lower than readState.Index'  (duration: 4.54µs)"],"step_count":2}
{"level":"warn","ts":"2026-05-27T06:51:24.351504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.537976ms","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-27T06:51:24.351588Z","caller":"traceutil/trace.go:171","msg":"trace[1882752553] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24551; }","duration":"304.676369ms","start":"2026-05-27T06:51:24.046893Z","end":"2026-05-27T06:51:24.351569Z","steps":["trace[1882752553] 'agreement among raft nodes before linearized reading'  (duration: 303.735861ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:51:24.351637Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:51:24.046868Z","time spent":"304.75809ms","remote":"127.0.0.1:56252","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":532,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-05-27T06:51:24.367425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.571578ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-27T06:51:24.367507Z","caller":"traceutil/trace.go:171","msg":"trace[809609342] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:24554; }","duration":"191.710142ms","start":"2026-05-27T06:51:24.175776Z","end":"2026-05-27T06:51:24.367486Z","steps":["trace[809609342] 'agreement among raft nodes before linearized reading'  (duration: 191.573249ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:51:24.368002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.880003ms","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-27T06:51:24.368093Z","caller":"traceutil/trace.go:171","msg":"trace[1352710842] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24554; }","duration":"321.023826ms","start":"2026-05-27T06:51:24.047046Z","end":"2026-05-27T06:51:24.36807Z","steps":["trace[1352710842] 'agreement among raft nodes before linearized reading'  (duration: 320.240401ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:51:24.368323Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:51:24.047003Z","time spent":"321.136409ms","remote":"127.0.0.1:56252","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":518,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"info","ts":"2026-05-27T06:51:24.521961Z","caller":"traceutil/trace.go:171","msg":"trace[1569897995] transaction","detail":"{read_only:false; response_revision:24555; number_of_response:1; }","duration":"166.16641ms","start":"2026-05-27T06:51:24.355763Z","end":"2026-05-27T06:51:24.521929Z","steps":["trace[1569897995] 'process raft request'  (duration: 151.783318ms)","trace[1569897995] 'compare'  (duration: 14.205989ms)"],"step_count":2}
{"level":"info","ts":"2026-05-27T06:51:24.52201Z","caller":"traceutil/trace.go:171","msg":"trace[1096262958] transaction","detail":"{read_only:false; response_revision:24556; number_of_response:1; }","duration":"149.950785ms","start":"2026-05-27T06:51:24.372038Z","end":"2026-05-27T06:51:24.521989Z","steps":["trace[1096262958] 'process raft request'  (duration: 149.828012ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:51:24.714787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.869572ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15440202542147240125 > lease_revoke:<id:56469e6808c4ffbb>","response":"size:29"}
{"level":"warn","ts":"2026-05-27T06:51:24.714827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.757461ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-27T06:51:24.714934Z","caller":"traceutil/trace.go:171","msg":"trace[928620418] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:24556; }","duration":"182.880504ms","start":"2026-05-27T06:51:24.532033Z","end":"2026-05-27T06:51:24.714914Z","steps":["trace[928620418] 'range keys from in-memory index tree'  (duration: 182.732921ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:51:24.8536Z","caller":"traceutil/trace.go:171","msg":"trace[277947823] transaction","detail":"{read_only:false; response_revision:24557; number_of_response:1; }","duration":"297.152088ms","start":"2026-05-27T06:51:24.556392Z","end":"2026-05-27T06:51:24.853545Z","steps":["trace[277947823] 'process raft request'  (duration: 296.896782ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:51:24.854267Z","caller":"traceutil/trace.go:171","msg":"trace[266510701] transaction","detail":"{read_only:false; response_revision:24558; number_of_response:1; }","duration":"276.747793ms","start":"2026-05-27T06:51:24.577447Z","end":"2026-05-27T06:51:24.854195Z","steps":["trace[266510701] 'process raft request'  (duration: 276.526989ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:51:24.854472Z","caller":"traceutil/trace.go:171","msg":"trace[1833946263] linearizableReadLoop","detail":"{readStateIndex:25352; appliedIndex:25350; }","duration":"244.790241ms","start":"2026-05-27T06:51:24.609651Z","end":"2026-05-27T06:51:24.854441Z","steps":["trace[1833946263] 'read index received'  (duration: 243.70493ms)","trace[1833946263] 'applied index is now lower than readState.Index'  (duration: 1.082411ms)"],"step_count":2}
{"level":"info","ts":"2026-05-27T06:51:24.854516Z","caller":"traceutil/trace.go:171","msg":"trace[854755129] transaction","detail":"{read_only:false; response_revision:24559; number_of_response:1; }","duration":"179.45095ms","start":"2026-05-27T06:51:24.675046Z","end":"2026-05-27T06:51:24.854497Z","steps":["trace[854755129] 'process raft request'  (duration: 179.084463ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:51:24.854818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.134197ms","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-27T06:51:24.854871Z","caller":"traceutil/trace.go:171","msg":"trace[1718199434] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24559; }","duration":"245.284289ms","start":"2026-05-27T06:51:24.609573Z","end":"2026-05-27T06:51:24.854858Z","steps":["trace[1718199434] 'agreement among raft nodes before linearized reading'  (duration: 245.051935ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:51:24.855021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.059689ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-05-27T06:51:24.855068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.311716ms","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-27T06:51:24.85511Z","caller":"traceutil/trace.go:171","msg":"trace[1225405837] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24559; }","duration":"181.370857ms","start":"2026-05-27T06:51:24.673727Z","end":"2026-05-27T06:51:24.855098Z","steps":["trace[1225405837] 'agreement among raft nodes before linearized reading'  (duration: 181.258135ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:51:24.855089Z","caller":"traceutil/trace.go:171","msg":"trace[1859373035] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24559; }","duration":"182.175851ms","start":"2026-05-27T06:51:24.672897Z","end":"2026-05-27T06:51:24.855073Z","steps":["trace[1859373035] 'agreement among raft nodes before linearized reading'  (duration: 181.912726ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:51:25.026805Z","caller":"traceutil/trace.go:171","msg":"trace[821059670] linearizableReadLoop","detail":"{readStateIndex:25355; appliedIndex:25354; }","duration":"135.311448ms","start":"2026-05-27T06:51:24.891462Z","end":"2026-05-27T06:51:25.026773Z","steps":["trace[821059670] 'read index received'  (duration: 128.325706ms)","trace[821059670] 'applied index is now lower than readState.Index'  (duration: 6.983822ms)"],"step_count":2}
{"level":"info","ts":"2026-05-27T06:51:25.026949Z","caller":"traceutil/trace.go:171","msg":"trace[348761653] transaction","detail":"{read_only:false; response_revision:24561; number_of_response:1; }","duration":"166.818232ms","start":"2026-05-27T06:51:24.860109Z","end":"2026-05-27T06:51:25.026927Z","steps":["trace[348761653] 'process raft request'  (duration: 159.684437ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:51:25.027242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.767178ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:9"}
{"level":"info","ts":"2026-05-27T06:51:25.027305Z","caller":"traceutil/trace.go:171","msg":"trace[271524701] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:24561; }","duration":"135.845019ms","start":"2026-05-27T06:51:24.891446Z","end":"2026-05-27T06:51:25.027291Z","steps":["trace[271524701] 'agreement among raft nodes before linearized reading'  (duration: 135.606934ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:51:25.305407Z","caller":"traceutil/trace.go:171","msg":"trace[1450961864] transaction","detail":"{read_only:false; response_revision:24562; number_of_response:1; }","duration":"370.630241ms","start":"2026-05-27T06:51:24.934754Z","end":"2026-05-27T06:51:25.305384Z","steps":["trace[1450961864] 'process raft request'  (duration: 276.722262ms)","trace[1450961864] 'compare'  (duration: 93.566433ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-27T06:51:25.305562Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:51:24.934647Z","time spent":"370.829885ms","remote":"127.0.0.1:56252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/capo-system/controller-leader-election-capo\" mod_revision:24547 > 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-27T06:51:25.30569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.46515ms","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-27T06:51:25.305768Z","caller":"traceutil/trace.go:171","msg":"trace[651643957] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24562; }","duration":"360.583272ms","start":"2026-05-27T06:51:24.945167Z","end":"2026-05-27T06:51:25.305751Z","steps":["trace[651643957] 'agreement among raft nodes before linearized reading'  (duration: 360.361647ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:51:25.305785Z","caller":"traceutil/trace.go:171","msg":"trace[1410831895] linearizableReadLoop","detail":"{readStateIndex:25356; appliedIndex:25355; }","duration":"278.315082ms","start":"2026-05-27T06:51:25.026883Z","end":"2026-05-27T06:51:25.305198Z","steps":["trace[1410831895] 'read index received'  (duration: 183.998416ms)","trace[1410831895] 'applied index is now lower than readState.Index'  (duration: 94.315586ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-27T06:51:25.305811Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:51:24.945156Z","time spent":"360.646803ms","remote":"127.0.0.1:56252","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-05-27T06:51:25.600946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.125577ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15440202542147240137 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:24548 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-27T06:51:25.601624Z","caller":"traceutil/trace.go:171","msg":"trace[983774914] transaction","detail":"{read_only:false; response_revision:24564; number_of_response:1; }","duration":"194.504704ms","start":"2026-05-27T06:51:25.406859Z","end":"2026-05-27T06:51:25.601364Z","steps":["trace[983774914] 'process raft request'  (duration: 194.187947ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:51:25.601406Z","caller":"traceutil/trace.go:171","msg":"trace[1345247900] transaction","detail":"{read_only:false; response_revision:24563; number_of_response:1; }","duration":"291.213765ms","start":"2026-05-27T06:51:25.31015Z","end":"2026-05-27T06:51:25.601364Z","steps":["trace[1345247900] 'process raft request'  (duration: 131.587178ms)","trace[1345247900] 'compare'  (duration: 158.789801ms)"],"step_count":2}
{"level":"info","ts":"2026-05-27T06:51:26.273968Z","caller":"traceutil/trace.go:171","msg":"trace[512028100] transaction","detail":"{read_only:false; response_revision:24566; number_of_response:1; }","duration":"101.844878ms","start":"2026-05-27T06:51:26.172098Z","end":"2026-05-27T06:51:26.273943Z","steps":["trace[512028100] 'process raft request'  (duration: 101.678845ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:51:26.58197Z","caller":"traceutil/trace.go:171","msg":"trace[1246687299] transaction","detail":"{read_only:false; response_revision:24567; number_of_response:1; }","duration":"226.084209ms","start":"2026-05-27T06:51:26.355812Z","end":"2026-05-27T06:51:26.581896Z","steps":["trace[1246687299] 'process raft request'  (duration: 225.962467ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:51:26.676669Z","caller":"traceutil/trace.go:171","msg":"trace[1132394227] transaction","detail":"{read_only:false; response_revision:24568; number_of_response:1; }","duration":"304.107639ms","start":"2026-05-27T06:51:26.372535Z","end":"2026-05-27T06:51:26.676642Z","steps":["trace[1132394227] 'process raft request'  (duration: 302.325955ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:51:26.676957Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:51:26.372503Z","time spent":"304.214671ms","remote":"127.0.0.1:56252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:24552 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:477 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"info","ts":"2026-05-27T06:51:26.677125Z","caller":"traceutil/trace.go:171","msg":"trace[413518210] linearizableReadLoop","detail":"{readStateIndex:25364; appliedIndex:25361; }","duration":"151.29666ms","start":"2026-05-27T06:51:26.525806Z","end":"2026-05-27T06:51:26.677102Z","steps":["trace[413518210] 'read index received'  (duration: 56.093527ms)","trace[413518210] 'applied index is now lower than readState.Index'  (duration: 95.202063ms)"],"step_count":2}
{"level":"info","ts":"2026-05-27T06:51:26.677168Z","caller":"traceutil/trace.go:171","msg":"trace[1764610046] transaction","detail":"{read_only:false; response_revision:24569; number_of_response:1; }","duration":"304.23776ms","start":"2026-05-27T06:51:26.372908Z","end":"2026-05-27T06:51:26.677145Z","steps":["trace[1764610046] 'process raft request'  (duration: 303.704631ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:51:26.677261Z","caller":"traceutil/trace.go:171","msg":"trace[1921114435] transaction","detail":"{read_only:false; response_revision:24570; number_of_response:1; }","duration":"304.296572ms","start":"2026-05-27T06:51:26.372925Z","end":"2026-05-27T06:51:26.677222Z","steps":["trace[1921114435] 'process raft request'  (duration: 304.068097ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:51:26.677394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.460553ms","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-27T06:51:26.677413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.601986ms","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-27T06:51:26.677439Z","caller":"traceutil/trace.go:171","msg":"trace[545932532] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24570; }","duration":"151.595385ms","start":"2026-05-27T06:51:26.525831Z","end":"2026-05-27T06:51:26.677426Z","steps":["trace[545932532] 'agreement among raft nodes before linearized reading'  (duration: 151.432972ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:51:26.677471Z","caller":"traceutil/trace.go:171","msg":"trace[1171158088] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24570; }","duration":"151.701937ms","start":"2026-05-27T06:51:26.525753Z","end":"2026-05-27T06:51:26.677455Z","steps":["trace[1171158088] 'agreement among raft nodes before linearized reading'  (duration: 151.502383ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:51:26.677718Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:51:26.37291Z","time spent":"304.467404ms","remote":"127.0.0.1:56252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:24553 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"warn","ts":"2026-05-27T06:51:26.677917Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:51:26.372877Z","time spent":"304.989905ms","remote":"127.0.0.1:56252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":497,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:24554 > success:<request_put:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" value_size:441 >> failure:<request_range:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" > >"}
{"level":"info","ts":"2026-05-27T06:51:32.111306Z","caller":"traceutil/trace.go:171","msg":"trace[267782900] linearizableReadLoop","detail":"{readStateIndex:25403; appliedIndex:25402; }","duration":"110.461291ms","start":"2026-05-27T06:51:32.000812Z","end":"2026-05-27T06:51:32.111273Z","steps":["trace[267782900] 'read index received'  (duration: 110.261677ms)","trace[267782900] 'applied index is now lower than readState.Index'  (duration: 198.604µs)"],"step_count":2}
{"level":"info","ts":"2026-05-27T06:51:32.111644Z","caller":"traceutil/trace.go:171","msg":"trace[1329120957] transaction","detail":"{read_only:false; response_revision:24608; number_of_response:1; }","duration":"287.840051ms","start":"2026-05-27T06:51:31.823791Z","end":"2026-05-27T06:51:32.111631Z","steps":["trace[1329120957] 'process raft request'  (duration: 287.340742ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:51:32.111922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.086023ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/\" range_end:\"/registry/rabbitmq.com/rabbitmqclusters0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-05-27T06:51:32.112014Z","caller":"traceutil/trace.go:171","msg":"trace[705613693] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/; range_end:/registry/rabbitmq.com/rabbitmqclusters0; response_count:0; response_revision:24608; }","duration":"111.204966ms","start":"2026-05-27T06:51:32.000778Z","end":"2026-05-27T06:51:32.111983Z","steps":["trace[705613693] 'agreement among raft nodes before linearized reading'  (duration: 111.065723ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:51:32.507398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.386547ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15440202542147240240 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" mod_revision:24500 > success:<request_put:<key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" value_size:465 >> failure:<request_range:<key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-27T06:51:32.507997Z","caller":"traceutil/trace.go:171","msg":"trace[1029600228] transaction","detail":"{read_only:false; response_revision:24609; number_of_response:1; }","duration":"386.161273ms","start":"2026-05-27T06:51:32.121816Z","end":"2026-05-27T06:51:32.507977Z","steps":["trace[1029600228] 'process raft request'  (duration: 273.122584ms)","trace[1029600228] 'compare'  (duration: 112.214464ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-27T06:51:32.508052Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:51:32.121806Z","time spent":"386.217565ms","remote":"127.0.0.1:56252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":542,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" mod_revision:24500 > success:<request_put:<key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" value_size:465 >> failure:<request_range:<key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" > >"}
{"level":"info","ts":"2026-05-27T06:51:32.760919Z","caller":"traceutil/trace.go:171","msg":"trace[1754917905] transaction","detail":"{read_only:false; response_revision:24610; number_of_response:1; }","duration":"401.266658ms","start":"2026-05-27T06:51:32.359615Z","end":"2026-05-27T06:51:32.760881Z","steps":["trace[1754917905] 'process raft request'  (duration: 333.559592ms)","trace[1754917905] 'compare'  (duration: 67.296508ms)"],"step_count":2}
{"level":"info","ts":"2026-05-27T06:51:32.760973Z","caller":"traceutil/trace.go:171","msg":"trace[473215039] transaction","detail":"{read_only:false; response_revision:24611; number_of_response:1; }","duration":"157.568848ms","start":"2026-05-27T06:51:32.603377Z","end":"2026-05-27T06:51:32.760946Z","steps":["trace[473215039] 'process raft request'  (duration: 157.505567ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:51:32.761082Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:51:32.359582Z","time spent":"401.415842ms","remote":"127.0.0.1:56252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" mod_revision:24557 > success:<request_put:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" value_size:415 >> failure:<request_range:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" > >"}
{"level":"info","ts":"2026-05-27T06:51:32.761149Z","caller":"traceutil/trace.go:171","msg":"trace[1997492150] linearizableReadLoop","detail":"{readStateIndex:25405; appliedIndex:25403; }","duration":"368.739205ms","start":"2026-05-27T06:51:32.392388Z","end":"2026-05-27T06:51:32.761127Z","steps":["trace[1997492150] 'read index received'  (duration: 2.578419ms)","trace[1997492150] 'applied index is now lower than readState.Index'  (duration: 366.159426ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-27T06:51:32.761341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.818819ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/operatorpolicies/\" range_end:\"/registry/rabbitmq.com/operatorpolicies0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-27T06:51:32.761418Z","caller":"traceutil/trace.go:171","msg":"trace[823375629] range","detail":"{range_begin:/registry/rabbitmq.com/operatorpolicies/; range_end:/registry/rabbitmq.com/operatorpolicies0; response_count:0; response_revision:24614; }","duration":"315.9333ms","start":"2026-05-27T06:51:32.445466Z","end":"2026-05-27T06:51:32.7614Z","steps":["trace[823375629] 'agreement among raft nodes before linearized reading'  (duration: 315.817968ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:51:32.761472Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:51:32.445448Z","time spent":"316.007693ms","remote":"127.0.0.1:33538","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":0,"response size":29,"request content":"key:\"/registry/rabbitmq.com/operatorpolicies/\" range_end:\"/registry/rabbitmq.com/operatorpolicies0\" count_only:true "}
{"level":"warn","ts":"2026-05-27T06:51:32.761658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.252315ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12217"}
{"level":"info","ts":"2026-05-27T06:51:32.761706Z","caller":"traceutil/trace.go:171","msg":"trace[2143541779] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:24614; }","duration":"369.345207ms","start":"2026-05-27T06:51:32.39235Z","end":"2026-05-27T06:51:32.761695Z","steps":["trace[2143541779] 'agreement among raft nodes before linearized reading'  (duration: 368.899328ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:51:32.761743Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:51:32.392332Z","time spent":"369.402118ms","remote":"127.0.0.1:56184","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12240,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "}
{"level":"info","ts":"2026-05-27T06:51:33.346436Z","caller":"traceutil/trace.go:171","msg":"trace[1264428597] transaction","detail":"{read_only:false; response_revision:24616; number_of_response:1; }","duration":"577.354874ms","start":"2026-05-27T06:51:32.769062Z","end":"2026-05-27T06:51:33.346417Z","steps":["trace[1264428597] 'process raft request'  (duration: 546.409532ms)","trace[1264428597] 'compare'  (duration: 30.349331ms)"],"step_count":2}
{"level":"info","ts":"2026-05-27T06:51:33.346532Z","caller":"traceutil/trace.go:171","msg":"trace[1689093794] linearizableReadLoop","detail":"{readStateIndex:25412; appliedIndex:25410; }","duration":"513.827198ms","start":"2026-05-27T06:51:32.832682Z","end":"2026-05-27T06:51:33.346509Z","steps":["trace[1689093794] 'read index received'  (duration: 482.808874ms)","trace[1689093794] 'applied index is now lower than readState.Index'  (duration: 31.017064ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-27T06:51:33.346563Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:51:32.769055Z","time spent":"577.444586ms","remote":"127.0.0.1:56252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":515,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/cert-manager/cert-manager-controller\" mod_revision:24504 > 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-27T06:51:33.346586Z","caller":"traceutil/trace.go:171","msg":"trace[1666718133] transaction","detail":"{read_only:false; response_revision:24617; number_of_response:1; }","duration":"576.931177ms","start":"2026-05-27T06:51:32.769626Z","end":"2026-05-27T06:51:33.346557Z","steps":["trace[1666718133] 'process raft request'  (duration: 576.729293ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:51:33.346664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"513.97088ms","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-27T06:51:33.346754Z","caller":"traceutil/trace.go:171","msg":"trace[1560981553] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:24617; }","duration":"514.087564ms","start":"2026-05-27T06:51:32.832648Z","end":"2026-05-27T06:51:33.346736Z","steps":["trace[1560981553] 'agreement among raft nodes before linearized reading'  (duration: 513.961731ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:51:33.346758Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:51:32.769617Z","time spent":"577.037849ms","remote":"127.0.0.1:56252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:24599 > 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-27T06:51:33.346801Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:51:32.832635Z","time spent":"514.155515ms","remote":"127.0.0.1:56456","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":29,"request content":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" "}
{"level":"info","ts":"2026-05-27T06:51:33.412225Z","caller":"traceutil/trace.go:171","msg":"trace[1245052336] transaction","detail":"{read_only:false; response_revision:24618; number_of_response:1; }","duration":"532.53409ms","start":"2026-05-27T06:51:32.879661Z","end":"2026-05-27T06:51:33.412195Z","steps":["trace[1245052336] 'process raft request'  (duration: 532.358117ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:51:33.412415Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:51:32.879634Z","time spent":"532.695334ms","remote":"127.0.0.1:56252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/capi-system/controller-leader-election-capi\" mod_revision:24601 > 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":"info","ts":"2026-05-27T06:51:33.504845Z","caller":"traceutil/trace.go:171","msg":"trace[221110540] linearizableReadLoop","detail":"{readStateIndex:25414; appliedIndex:25412; }","duration":"158.239721ms","start":"2026-05-27T06:51:33.346579Z","end":"2026-05-27T06:51:33.504818Z","steps":["trace[221110540] 'read index received'  (duration: 65.562745ms)","trace[221110540] 'applied index is now lower than readState.Index'  (duration: 92.675866ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-27T06:51:33.505079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"439.674562ms","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-27T06:51:33.505124Z","caller":"traceutil/trace.go:171","msg":"trace[1692580465] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24619; }","duration":"439.775063ms","start":"2026-05-27T06:51:33.065339Z","end":"2026-05-27T06:51:33.505115Z","steps":["trace[1692580465] 'agreement among raft nodes before linearized reading'  (duration: 439.61101ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:51:33.505161Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:51:33.065319Z","time spent":"439.834665ms","remote":"127.0.0.1:56252","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-05-27T06:51:33.505338Z","caller":"traceutil/trace.go:171","msg":"trace[477877662] transaction","detail":"{read_only:false; response_revision:24619; number_of_response:1; }","duration":"172.680943ms","start":"2026-05-27T06:51:33.332633Z","end":"2026-05-27T06:51:33.505314Z","steps":["trace[477877662] 'process raft request'  (duration: 170.558162ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:51:33.505465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"549.399308ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-27T06:51:33.505513Z","caller":"traceutil/trace.go:171","msg":"trace[390180145] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0; response_count:0; response_revision:24619; }","duration":"549.485471ms","start":"2026-05-27T06:51:32.956011Z","end":"2026-05-27T06:51:33.505496Z","steps":["trace[390180145] 'agreement among raft nodes before linearized reading'  (duration: 549.41958ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:51:33.504978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.526478ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-05-27T06:51:33.505612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.484129ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-27T06:51:33.505608Z","caller":"traceutil/trace.go:171","msg":"trace[509154020] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:24619; }","duration":"192.19546ms","start":"2026-05-27T06:51:33.313381Z","end":"2026-05-27T06:51:33.505577Z","steps":["trace[509154020] 'agreement among raft nodes before linearized reading'  (duration: 191.485656ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:51:33.505649Z","caller":"traceutil/trace.go:171","msg":"trace[1697420904] range","detail":"{range_begin:/registry/services/specs/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:24619; }","duration":"155.54318ms","start":"2026-05-27T06:51:33.350098Z","end":"2026-05-27T06:51:33.505641Z","steps":["trace[1697420904] 'agreement among raft nodes before linearized reading'  (duration: 155.489459ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:51:33.50574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"580.822291ms","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-27T06:51:33.505834Z","caller":"traceutil/trace.go:171","msg":"trace[1936117957] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24619; }","duration":"580.966253ms","start":"2026-05-27T06:51:32.924846Z","end":"2026-05-27T06:51:33.505812Z","steps":["trace[1936117957] 'agreement among raft nodes before linearized reading'  (duration: 580.675858ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:51:33.505546Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:51:32.955988Z","time spent":"549.549752ms","remote":"127.0.0.1:48718","response type":"/etcdserverpb.KV/Range","request count":0,"request size":152,"response count":0,"response size":29,"request content":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0\" "}
{"level":"warn","ts":"2026-05-27T06:51:33.505892Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:51:32.924825Z","time spent":"581.056345ms","remote":"127.0.0.1:56252","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-27T06:51:39.050915Z","caller":"traceutil/trace.go:171","msg":"trace[831673047] transaction","detail":"{read_only:false; response_revision:24713; number_of_response:1; }","duration":"311.789933ms","start":"2026-05-27T06:51:38.739104Z","end":"2026-05-27T06:51:39.050894Z","steps":["trace[831673047] 'process raft request'  (duration: 311.590308ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:51:39.051042Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:51:38.739081Z","time spent":"311.897514ms","remote":"127.0.0.1:56252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:24581 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"info","ts":"2026-05-27T06:51:39.08662Z","caller":"traceutil/trace.go:171","msg":"trace[2113485230] linearizableReadLoop","detail":"{readStateIndex:25513; appliedIndex:25508; }","duration":"293.399207ms","start":"2026-05-27T06:51:38.793198Z","end":"2026-05-27T06:51:39.086598Z","steps":["trace[2113485230] 'read index received'  (duration: 257.508911ms)","trace[2113485230] 'applied index is now lower than readState.Index'  (duration: 35.889386ms)"],"step_count":2}
{"level":"info","ts":"2026-05-27T06:51:39.086662Z","caller":"traceutil/trace.go:171","msg":"trace[965917126] transaction","detail":"{read_only:false; response_revision:24714; number_of_response:1; }","duration":"297.732339ms","start":"2026-05-27T06:51:38.788889Z","end":"2026-05-27T06:51:39.086621Z","steps":["trace[965917126] 'process raft request'  (duration: 297.475014ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:51:39.086764Z","caller":"traceutil/trace.go:171","msg":"trace[976121707] transaction","detail":"{read_only:false; response_revision:24717; number_of_response:1; }","duration":"296.616947ms","start":"2026-05-27T06:51:38.790134Z","end":"2026-05-27T06:51:39.086751Z","steps":["trace[976121707] 'process raft request'  (duration: 296.430114ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:51:39.086784Z","caller":"traceutil/trace.go:171","msg":"trace[1298948511] transaction","detail":"{read_only:false; response_revision:24716; number_of_response:1; }","duration":"297.639066ms","start":"2026-05-27T06:51:38.789072Z","end":"2026-05-27T06:51:39.086711Z","steps":["trace[1298948511] 'process raft request'  (duration: 297.461183ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:51:39.086954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.741023ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusterbackups/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterbackups0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-05-27T06:51:39.086967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.422171ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c1298c0f-92c2-455e-9559-df8944e5022d\" ","response":"range_response_count:1 size:3644"}
{"level":"info","ts":"2026-05-27T06:51:39.086996Z","caller":"traceutil/trace.go:171","msg":"trace[106464134] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusterbackups/; range_end:/registry/pxc.percona.com/perconaxtradbclusterbackups0; response_count:0; response_revision:24717; }","duration":"293.802804ms","start":"2026-05-27T06:51:38.793178Z","end":"2026-05-27T06:51:39.086981Z","steps":["trace[106464134] 'agreement among raft nodes before linearized reading'  (duration: 293.706222ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:51:39.087005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.807143ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:9"}
{"level":"info","ts":"2026-05-27T06:51:39.087024Z","caller":"traceutil/trace.go:171","msg":"trace[1709529635] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-c1298c0f-92c2-455e-9559-df8944e5022d; range_end:; response_count:1; response_revision:24717; }","duration":"290.549343ms","start":"2026-05-27T06:51:38.796459Z","end":"2026-05-27T06:51:39.087008Z","steps":["trace[1709529635] 'agreement among raft nodes before linearized reading'  (duration: 290.340459ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:51:39.087052Z","caller":"traceutil/trace.go:171","msg":"trace[1163271940] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:24717; }","duration":"174.870794ms","start":"2026-05-27T06:51:38.912171Z","end":"2026-05-27T06:51:39.087042Z","steps":["trace[1163271940] 'agreement among raft nodes before linearized reading'  (duration: 174.63902ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:51:39.087001Z","caller":"traceutil/trace.go:171","msg":"trace[1274727979] transaction","detail":"{read_only:false; response_revision:24715; number_of_response:1; }","duration":"297.979463ms","start":"2026-05-27T06:51:38.788975Z","end":"2026-05-27T06:51:39.086955Z","steps":["trace[1274727979] 'process raft request'  (duration: 297.525665ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:51:39.087153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.193887ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/addons.cluster.x-k8s.io/clusterresourcesetbindings/\" range_end:\"/registry/addons.cluster.x-k8s.io/clusterresourcesetbindings0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-27T06:51:39.087183Z","caller":"traceutil/trace.go:171","msg":"trace[1633552547] range","detail":"{range_begin:/registry/addons.cluster.x-k8s.io/clusterresourcesetbindings/; range_end:/registry/addons.cluster.x-k8s.io/clusterresourcesetbindings0; response_count:0; response_revision:24717; }","duration":"246.272759ms","start":"2026-05-27T06:51:38.840902Z","end":"2026-05-27T06:51:39.087175Z","steps":["trace[1633552547] 'agreement among raft nodes before linearized reading'  (duration: 246.224908ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:51:39.08733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.661504ms","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-27T06:51:39.087358Z","caller":"traceutil/trace.go:171","msg":"trace[2122690205] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24717; }","duration":"274.719126ms","start":"2026-05-27T06:51:38.812632Z","end":"2026-05-27T06:51:39.087351Z","steps":["trace[2122690205] 'agreement among raft nodes before linearized reading'  (duration: 274.587983ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:51:39.321643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.536301ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15440202542147240532 username:\"kube-apiserver-etcd-client\" auth_revision:1 > lease_grant:<ttl:15-second id:56469e6808c50253>","response":"size:41"}
{"level":"info","ts":"2026-05-27T06:51:39.371848Z","caller":"traceutil/trace.go:171","msg":"trace[859287318] transaction","detail":"{read_only:false; response_revision:24718; number_of_response:1; }","duration":"276.263484ms","start":"2026-05-27T06:51:39.095558Z","end":"2026-05-27T06:51:39.371822Z","steps":["trace[859287318] 'process raft request'  (duration: 275.995249ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:51:39.372103Z","caller":"traceutil/trace.go:171","msg":"trace[388960567] linearizableReadLoop","detail":"{readStateIndex:25516; appliedIndex:25514; }","duration":"119.525132ms","start":"2026-05-27T06:51:39.252553Z","end":"2026-05-27T06:51:39.372078Z","steps":["trace[388960567] 'read index received'  (duration: 119.110154ms)","trace[388960567] 'applied index is now lower than readState.Index'  (duration: 413.368µs)"],"step_count":2}
{"level":"info","ts":"2026-05-27T06:51:39.372236Z","caller":"traceutil/trace.go:171","msg":"trace[1889737019] transaction","detail":"{read_only:false; response_revision:24719; number_of_response:1; }","duration":"274.178074ms","start":"2026-05-27T06:51:39.097983Z","end":"2026-05-27T06:51:39.372161Z","steps":["trace[1889737019] 'process raft request'  (duration: 273.771487ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:51:39.372305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.735665ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-27T06:51:39.372397Z","caller":"traceutil/trace.go:171","msg":"trace[1123475087] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:24719; }","duration":"119.852627ms","start":"2026-05-27T06:51:39.252523Z","end":"2026-05-27T06:51:39.372376Z","steps":["trace[1123475087] 'agreement among raft nodes before linearized reading'  (duration: 119.665724ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:51:39.538845Z","caller":"traceutil/trace.go:171","msg":"trace[118853084] linearizableReadLoop","detail":"{readStateIndex:25517; appliedIndex:25516; }","duration":"166.669319ms","start":"2026-05-27T06:51:39.372154Z","end":"2026-05-27T06:51:39.538824Z","steps":["trace[118853084] 'read index received'  (duration: 106.865532ms)","trace[118853084] 'applied index is now lower than readState.Index'  (duration: 59.802547ms)"],"step_count":2}
{"level":"info","ts":"2026-05-27T06:51:39.538905Z","caller":"traceutil/trace.go:171","msg":"trace[1922251197] transaction","detail":"{read_only:false; response_revision:24720; number_of_response:1; }","duration":"216.074939ms","start":"2026-05-27T06:51:39.322779Z","end":"2026-05-27T06:51:39.538854Z","steps":["trace[1922251197] 'process raft request'  (duration: 156.148671ms)","trace[1922251197] 'compare'  (duration: 59.660824ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-27T06:51:39.539013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.474466ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-05-27T06:51:39.53905Z","caller":"traceutil/trace.go:171","msg":"trace[1572092998] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:24720; }","duration":"251.534467ms","start":"2026-05-27T06:51:39.287504Z","end":"2026-05-27T06:51:39.539039Z","steps":["trace[1572092998] 'agreement among raft nodes before linearized reading'  (duration: 251.431405ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:51:39.539108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.837571ms","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-27T06:51:39.539204Z","caller":"traceutil/trace.go:171","msg":"trace[1522448580] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24720; }","duration":"167.990764ms","start":"2026-05-27T06:51:39.371189Z","end":"2026-05-27T06:51:39.53918Z","steps":["trace[1522448580] 'agreement among raft nodes before linearized reading'  (duration: 167.651848ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:51:39.562828Z","caller":"traceutil/trace.go:171","msg":"trace[43471775] transaction","detail":"{read_only:false; response_revision:24721; number_of_response:1; }","duration":"111.98432ms","start":"2026-05-27T06:51:39.450819Z","end":"2026-05-27T06:51:39.562803Z","steps":["trace[43471775] 'process raft request'  (duration: 111.792306ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:51:39.591273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.169608ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c1298c0f-92c2-455e-9559-df8944e5022d\" ","response":"range_response_count:1 size:3764"}
{"level":"info","ts":"2026-05-27T06:51:39.591401Z","caller":"traceutil/trace.go:171","msg":"trace[510484076] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-c1298c0f-92c2-455e-9559-df8944e5022d; range_end:; response_count:1; response_revision:24723; }","duration":"185.385092ms","start":"2026-05-27T06:51:39.405986Z","end":"2026-05-27T06:51:39.591371Z","steps":["trace[510484076] 'agreement among raft nodes before linearized reading'  (duration: 185.063196ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:51:41.21368Z","caller":"traceutil/trace.go:171","msg":"trace[808729220] transaction","detail":"{read_only:false; response_revision:24733; number_of_response:1; }","duration":"118.454571ms","start":"2026-05-27T06:51:41.095205Z","end":"2026-05-27T06:51:41.213659Z","steps":["trace[808729220] 'process raft request'  (duration: 118.374359ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:51:41.213691Z","caller":"traceutil/trace.go:171","msg":"trace[191400774] transaction","detail":"{read_only:false; response_revision:24732; number_of_response:1; }","duration":"118.541602ms","start":"2026-05-27T06:51:41.095121Z","end":"2026-05-27T06:51:41.213663Z","steps":["trace[191400774] 'process raft request'  (duration: 118.261047ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:51:41.21381Z","caller":"traceutil/trace.go:171","msg":"trace[1239336204] transaction","detail":"{read_only:false; response_revision:24734; number_of_response:1; }","duration":"118.544452ms","start":"2026-05-27T06:51:41.095241Z","end":"2026-05-27T06:51:41.213785Z","steps":["trace[1239336204] 'process raft request'  (duration: 118.377799ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:51:45.949758Z","caller":"traceutil/trace.go:171","msg":"trace[711444312] linearizableReadLoop","detail":"{readStateIndex:25586; appliedIndex:25585; }","duration":"274.128604ms","start":"2026-05-27T06:51:45.67561Z","end":"2026-05-27T06:51:45.949739Z","steps":["trace[711444312] 'read index received'  (duration: 250.740813ms)","trace[711444312] 'applied index is now lower than readState.Index'  (duration: 23.387021ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-27T06:51:45.949866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.258363ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-27T06:51:45.949837Z","caller":"traceutil/trace.go:171","msg":"trace[1229221993] transaction","detail":"{read_only:false; response_revision:24788; number_of_response:1; }","duration":"296.709859ms","start":"2026-05-27T06:51:45.653091Z","end":"2026-05-27T06:51:45.949801Z","steps":["trace[1229221993] 'process raft request'  (duration: 273.329948ms)","trace[1229221993] 'compare'  (duration: 23.002514ms)"],"step_count":2}
{"level":"info","ts":"2026-05-27T06:51:45.949884Z","caller":"traceutil/trace.go:171","msg":"trace[897790904] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24788; }","duration":"277.297243ms","start":"2026-05-27T06:51:45.672581Z","end":"2026-05-27T06:51:45.949879Z","steps":["trace[897790904] 'agreement among raft nodes before linearized reading'  (duration: 277.244402ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:51:45.969673Z","caller":"traceutil/trace.go:171","msg":"trace[762027451] transaction","detail":"{read_only:false; response_revision:24790; number_of_response:1; }","duration":"290.339118ms","start":"2026-05-27T06:51:45.679305Z","end":"2026-05-27T06:51:45.969644Z","steps":["trace[762027451] 'process raft request'  (duration: 290.217826ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:51:45.969712Z","caller":"traceutil/trace.go:171","msg":"trace[1955504599] transaction","detail":"{read_only:false; response_revision:24789; number_of_response:1; }","duration":"290.382739ms","start":"2026-05-27T06:51:45.679305Z","end":"2026-05-27T06:51:45.969688Z","steps":["trace[1955504599] 'process raft request'  (duration: 290.054813ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:51:45.969686Z","caller":"traceutil/trace.go:171","msg":"trace[1161432660] transaction","detail":"{read_only:false; response_revision:24791; number_of_response:1; }","duration":"261.357823ms","start":"2026-05-27T06:51:45.708303Z","end":"2026-05-27T06:51:45.969661Z","steps":["trace[1161432660] 'process raft request'  (duration: 261.259241ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:51:45.969886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.554207ms","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-27T06:51:45.96994Z","caller":"traceutil/trace.go:171","msg":"trace[1777404673] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24791; }","duration":"251.66051ms","start":"2026-05-27T06:51:45.718267Z","end":"2026-05-27T06:51:45.969928Z","steps":["trace[1777404673] 'agreement among raft nodes before linearized reading'  (duration: 251.484096ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:51:54.680083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.639572ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15440202542147240870 > lease_revoke:<id:56469e6808c50253>","response":"size:29"}
{"level":"warn","ts":"2026-05-27T06:51:54.68026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.645615ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-27T06:51:54.680359Z","caller":"traceutil/trace.go:171","msg":"trace[411015264] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:24862; }","duration":"152.773207ms","start":"2026-05-27T06:51:54.527573Z","end":"2026-05-27T06:51:54.680347Z","steps":["trace[411015264] 'range keys from in-memory index tree'  (duration: 152.613975ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:51:55.338482Z","caller":"traceutil/trace.go:171","msg":"trace[501336459] transaction","detail":"{read_only:false; response_revision:24863; number_of_response:1; }","duration":"102.999059ms","start":"2026-05-27T06:51:55.235455Z","end":"2026-05-27T06:51:55.338454Z","steps":["trace[501336459] 'process raft request'  (duration: 102.754015ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:51:55.508019Z","caller":"traceutil/trace.go:171","msg":"trace[563175530] transaction","detail":"{read_only:false; response_revision:24864; number_of_response:1; }","duration":"255.558003ms","start":"2026-05-27T06:51:55.252431Z","end":"2026-05-27T06:51:55.507989Z","steps":["trace[563175530] 'process raft request'  (duration: 169.132636ms)","trace[563175530] 'compare'  (duration: 85.910708ms)"],"step_count":2}
{"level":"info","ts":"2026-05-27T06:51:55.508393Z","caller":"traceutil/trace.go:171","msg":"trace[1230619954] transaction","detail":"{read_only:false; response_revision:24867; number_of_response:1; }","duration":"237.662237ms","start":"2026-05-27T06:51:55.270709Z","end":"2026-05-27T06:51:55.508371Z","steps":["trace[1230619954] 'process raft request'  (duration: 237.589196ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:51:55.508556Z","caller":"traceutil/trace.go:171","msg":"trace[887514645] transaction","detail":"{read_only:false; response_revision:24868; number_of_response:1; }","duration":"223.613912ms","start":"2026-05-27T06:51:55.284931Z","end":"2026-05-27T06:51:55.508545Z","steps":["trace[887514645] 'process raft request'  (duration: 223.406519ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:51:55.508552Z","caller":"traceutil/trace.go:171","msg":"trace[1396993324] transaction","detail":"{read_only:false; response_revision:24866; number_of_response:1; }","duration":"240.214865ms","start":"2026-05-27T06:51:55.26831Z","end":"2026-05-27T06:51:55.508525Z","steps":["trace[1396993324] 'process raft request'  (duration: 239.888259ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:51:55.508361Z","caller":"traceutil/trace.go:171","msg":"trace[1064503668] transaction","detail":"{read_only:false; response_revision:24865; number_of_response:1; }","duration":"245.916313ms","start":"2026-05-27T06:51:55.26242Z","end":"2026-05-27T06:51:55.508336Z","steps":["trace[1064503668] 'process raft request'  (duration: 245.511524ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:51:55.956509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.717266ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15440202542147240885 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/capo-system/controller-leader-election-capo\" mod_revision:24856 > 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-27T06:51:55.956723Z","caller":"traceutil/trace.go:171","msg":"trace[1752035444] linearizableReadLoop","detail":"{readStateIndex:25671; appliedIndex:25669; }","duration":"225.746682ms","start":"2026-05-27T06:51:55.730951Z","end":"2026-05-27T06:51:55.956697Z","steps":["trace[1752035444] 'read index received'  (duration: 22.855ms)","trace[1752035444] 'applied index is now lower than readState.Index'  (duration: 202.889422ms)"],"step_count":2}
{"level":"info","ts":"2026-05-27T06:51:55.95675Z","caller":"traceutil/trace.go:171","msg":"trace[1253986109] transaction","detail":"{read_only:false; response_revision:24871; number_of_response:1; }","duration":"250.331705ms","start":"2026-05-27T06:51:55.706384Z","end":"2026-05-27T06:51:55.956715Z","steps":["trace[1253986109] 'process raft request'  (duration: 148.309413ms)","trace[1253986109] 'compare'  (duration: 101.499603ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-27T06:51:55.956875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.906604ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-27T06:51:55.95695Z","caller":"traceutil/trace.go:171","msg":"trace[1551007848] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24871; }","duration":"226.016427ms","start":"2026-05-27T06:51:55.730917Z","end":"2026-05-27T06:51:55.956933Z","steps":["trace[1551007848] 'agreement among raft nodes before linearized reading'  (duration: 225.870834ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:51:55.957107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.997772ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/shovels/\" range_end:\"/registry/rabbitmq.com/shovels0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-27T06:51:55.957218Z","caller":"traceutil/trace.go:171","msg":"trace[2116365564] range","detail":"{range_begin:/registry/rabbitmq.com/shovels/; range_end:/registry/rabbitmq.com/shovels0; response_count:0; response_revision:24871; }","duration":"196.138075ms","start":"2026-05-27T06:51:55.761057Z","end":"2026-05-27T06:51:55.957195Z","steps":["trace[2116365564] 'agreement among raft nodes before linearized reading'  (duration: 195.984532ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:51:56.370348Z","caller":"traceutil/trace.go:171","msg":"trace[637137659] transaction","detail":"{read_only:false; response_revision:24877; number_of_response:1; }","duration":"105.346694ms","start":"2026-05-27T06:51:56.264974Z","end":"2026-05-27T06:51:56.370321Z","steps":["trace[637137659] 'process raft request'  (duration: 105.189801ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:52:09.890641Z","caller":"traceutil/trace.go:171","msg":"trace[832078386] linearizableReadLoop","detail":"{readStateIndex:25786; appliedIndex:25785; }","duration":"217.957066ms","start":"2026-05-27T06:52:09.672659Z","end":"2026-05-27T06:52:09.890616Z","steps":["trace[832078386] 'read index received'  (duration: 217.774472ms)","trace[832078386] 'applied index is now lower than readState.Index'  (duration: 181.554µs)"],"step_count":2}
{"level":"warn","ts":"2026-05-27T06:52:09.890789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.108898ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-27T06:52:09.890827Z","caller":"traceutil/trace.go:171","msg":"trace[1176246236] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24982; }","duration":"218.20538ms","start":"2026-05-27T06:52:09.672609Z","end":"2026-05-27T06:52:09.890814Z","steps":["trace[1176246236] 'agreement among raft nodes before linearized reading'  (duration: 218.128409ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:52:09.890822Z","caller":"traceutil/trace.go:171","msg":"trace[791867991] transaction","detail":"{read_only:false; response_revision:24982; number_of_response:1; }","duration":"276.781804ms","start":"2026-05-27T06:52:09.614006Z","end":"2026-05-27T06:52:09.890787Z","steps":["trace[791867991] 'process raft request'  (duration: 276.442988ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:52:10.517045Z","caller":"traceutil/trace.go:171","msg":"trace[1111533687] transaction","detail":"{read_only:false; response_revision:24990; number_of_response:1; }","duration":"106.210791ms","start":"2026-05-27T06:52:10.410806Z","end":"2026-05-27T06:52:10.517017Z","steps":["trace[1111533687] 'process raft request'  (duration: 105.955786ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:52:10.729904Z","caller":"traceutil/trace.go:171","msg":"trace[1204948764] linearizableReadLoop","detail":"{readStateIndex:25795; appliedIndex:25794; }","duration":"101.849757ms","start":"2026-05-27T06:52:10.628033Z","end":"2026-05-27T06:52:10.729883Z","steps":["trace[1204948764] 'read index received'  (duration: 24.798396ms)","trace[1204948764] 'applied index is now lower than readState.Index'  (duration: 77.050021ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-27T06:52:10.73005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.994091ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/subnets/\" range_end:\"/registry/openstack.k-orc.cloud/subnets0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-27T06:52:10.730087Z","caller":"traceutil/trace.go:171","msg":"trace[1586358427] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/subnets/; range_end:/registry/openstack.k-orc.cloud/subnets0; response_count:0; response_revision:24991; }","duration":"102.055043ms","start":"2026-05-27T06:52:10.628021Z","end":"2026-05-27T06:52:10.730076Z","steps":["trace[1586358427] 'agreement among raft nodes before linearized reading'  (duration: 101.935921ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:52:10.730382Z","caller":"traceutil/trace.go:171","msg":"trace[1167393664] transaction","detail":"{read_only:false; response_revision:24991; number_of_response:1; }","duration":"207.939247ms","start":"2026-05-27T06:52:10.522429Z","end":"2026-05-27T06:52:10.730368Z","steps":["trace[1167393664] 'process raft request'  (duration: 130.474607ms)","trace[1167393664] 'compare'  (duration: 76.680955ms)"],"step_count":2}
{"level":"info","ts":"2026-05-27T06:52:29.949432Z","caller":"traceutil/trace.go:171","msg":"trace[611637472] transaction","detail":"{read_only:false; response_revision:25135; number_of_response:1; }","duration":"275.379637ms","start":"2026-05-27T06:52:29.674026Z","end":"2026-05-27T06:52:29.949405Z","steps":["trace[611637472] 'process raft request'  (duration: 275.162193ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:52:29.950661Z","caller":"traceutil/trace.go:171","msg":"trace[1484359358] transaction","detail":"{read_only:false; response_revision:25137; number_of_response:1; }","duration":"275.52257ms","start":"2026-05-27T06:52:29.67512Z","end":"2026-05-27T06:52:29.950643Z","steps":["trace[1484359358] 'process raft request'  (duration: 275.438028ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:52:29.9508Z","caller":"traceutil/trace.go:171","msg":"trace[77998475] linearizableReadLoop","detail":"{readStateIndex:25944; appliedIndex:25942; }","duration":"275.913387ms","start":"2026-05-27T06:52:29.674867Z","end":"2026-05-27T06:52:29.950781Z","steps":["trace[77998475] 'read index received'  (duration: 274.335697ms)","trace[77998475] 'applied index is now lower than readState.Index'  (duration: 1.5766ms)"],"step_count":2}
{"level":"info","ts":"2026-05-27T06:52:29.950828Z","caller":"traceutil/trace.go:171","msg":"trace[1192887198] transaction","detail":"{read_only:false; response_revision:25136; number_of_response:1; }","duration":"276.331974ms","start":"2026-05-27T06:52:29.674451Z","end":"2026-05-27T06:52:29.950783Z","steps":["trace[1192887198] 'process raft request'  (duration: 275.995738ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:52:29.950905Z","caller":"traceutil/trace.go:171","msg":"trace[1830637566] transaction","detail":"{read_only:false; response_revision:25138; number_of_response:1; }","duration":"274.760715ms","start":"2026-05-27T06:52:29.676132Z","end":"2026-05-27T06:52:29.950893Z","steps":["trace[1830637566] 'process raft request'  (duration: 274.46271ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:52:29.950978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.847917ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-05-27T06:52:29.951043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.156951ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-27T06:52:29.951417Z","caller":"traceutil/trace.go:171","msg":"trace[1681395851] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25138; }","duration":"276.563569ms","start":"2026-05-27T06:52:29.674834Z","end":"2026-05-27T06:52:29.951398Z","steps":["trace[1681395851] 'agreement among raft nodes before linearized reading'  (duration: 276.159671ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:52:29.951056Z","caller":"traceutil/trace.go:171","msg":"trace[1202366882] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:25138; }","duration":"205.98185ms","start":"2026-05-27T06:52:29.745057Z","end":"2026-05-27T06:52:29.951039Z","steps":["trace[1202366882] 'agreement among raft nodes before linearized reading'  (duration: 205.852227ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:52:35.91846Z","caller":"traceutil/trace.go:171","msg":"trace[1049632750] transaction","detail":"{read_only:false; response_revision:25178; number_of_response:1; }","duration":"231.943698ms","start":"2026-05-27T06:52:35.686491Z","end":"2026-05-27T06:52:35.918435Z","steps":["trace[1049632750] 'process raft request'  (duration: 231.711444ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:52:35.928417Z","caller":"traceutil/trace.go:171","msg":"trace[1247090636] transaction","detail":"{read_only:false; response_revision:25179; number_of_response:1; }","duration":"173.318663ms","start":"2026-05-27T06:52:35.755078Z","end":"2026-05-27T06:52:35.928397Z","steps":["trace[1247090636] 'process raft request'  (duration: 173.189351ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:52:36.115067Z","caller":"traceutil/trace.go:171","msg":"trace[2074331279] transaction","detail":"{read_only:false; response_revision:25181; number_of_response:1; }","duration":"142.896211ms","start":"2026-05-27T06:52:35.972135Z","end":"2026-05-27T06:52:36.115031Z","steps":["trace[2074331279] 'process raft request'  (duration: 116.742899ms)","trace[2074331279] 'compare'  (duration: 25.905838ms)"],"step_count":2}
{"level":"info","ts":"2026-05-27T06:52:36.115347Z","caller":"traceutil/trace.go:171","msg":"trace[57484876] transaction","detail":"{read_only:false; response_revision:25182; number_of_response:1; }","duration":"142.763228ms","start":"2026-05-27T06:52:35.972546Z","end":"2026-05-27T06:52:36.115309Z","steps":["trace[57484876] 'process raft request'  (duration: 142.425402ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:52:36.435307Z","caller":"traceutil/trace.go:171","msg":"trace[1673866585] transaction","detail":"{read_only:false; response_revision:25183; number_of_response:1; }","duration":"331.027855ms","start":"2026-05-27T06:52:36.104244Z","end":"2026-05-27T06:52:36.435272Z","steps":["trace[1673866585] 'process raft request'  (duration: 330.843492ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:52:36.435503Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:52:36.104213Z","time spent":"331.185659ms","remote":"127.0.0.1:56252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/capi-system/controller-leader-election-capi\" mod_revision:25170 > 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":"info","ts":"2026-05-27T06:52:36.587436Z","caller":"traceutil/trace.go:171","msg":"trace[1890984704] transaction","detail":"{read_only:false; response_revision:25184; number_of_response:1; }","duration":"468.32133ms","start":"2026-05-27T06:52:36.119066Z","end":"2026-05-27T06:52:36.587388Z","steps":["trace[1890984704] 'process raft request'  (duration: 409.727367ms)","trace[1890984704] 'compare'  (duration: 58.385999ms)"],"step_count":2}
{"level":"info","ts":"2026-05-27T06:52:36.587693Z","caller":"traceutil/trace.go:171","msg":"trace[1643746706] transaction","detail":"{read_only:false; response_revision:25185; number_of_response:1; }","duration":"374.552454ms","start":"2026-05-27T06:52:36.213102Z","end":"2026-05-27T06:52:36.587655Z","steps":["trace[1643746706] 'process raft request'  (duration: 374.228548ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:52:36.587716Z","caller":"traceutil/trace.go:171","msg":"trace[1159614701] transaction","detail":"{read_only:false; response_revision:25186; number_of_response:1; }","duration":"372.747491ms","start":"2026-05-27T06:52:36.214939Z","end":"2026-05-27T06:52:36.587687Z","steps":["trace[1159614701] 'process raft request'  (duration: 372.618738ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:52:36.587757Z","caller":"traceutil/trace.go:171","msg":"trace[1124177463] transaction","detail":"{read_only:false; response_revision:25187; number_of_response:1; }","duration":"113.186361ms","start":"2026-05-27T06:52:36.474546Z","end":"2026-05-27T06:52:36.587733Z","steps":["trace[1124177463] 'process raft request'  (duration: 113.126739ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:52:36.587701Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:52:36.119043Z","time spent":"468.559125ms","remote":"127.0.0.1:56252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:25169 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-05-27T06:52:36.587942Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:52:36.214929Z","time spent":"372.880833ms","remote":"127.0.0.1:56252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/capo-system/controller-leader-election-capo\" mod_revision:25172 > success:<request_put:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" > >"}
{"level":"warn","ts":"2026-05-27T06:52:36.587866Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:52:36.213074Z","time spent":"374.700617ms","remote":"127.0.0.1:56252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":607,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" mod_revision:25171 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" value_size:506 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" > >"}
{"level":"warn","ts":"2026-05-27T06:52:36.588125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.861943ms","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-27T06:52:36.588169Z","caller":"traceutil/trace.go:171","msg":"trace[1568436987] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25187; }","duration":"295.941675ms","start":"2026-05-27T06:52:36.292212Z","end":"2026-05-27T06:52:36.588154Z","steps":["trace[1568436987] 'agreement among raft nodes before linearized reading'  (duration: 295.776172ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:52:36.588686Z","caller":"traceutil/trace.go:171","msg":"trace[781582482] linearizableReadLoop","detail":"{readStateIndex:25995; appliedIndex:25991; }","duration":"295.506446ms","start":"2026-05-27T06:52:36.292273Z","end":"2026-05-27T06:52:36.587779Z","steps":["trace[781582482] 'read index received'  (duration: 142.810281ms)","trace[781582482] 'applied index is now lower than readState.Index'  (duration: 152.693785ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-27T06:52:36.588967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.984379ms","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-27T06:52:36.589005Z","caller":"traceutil/trace.go:171","msg":"trace[454493917] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25187; }","duration":"257.077401ms","start":"2026-05-27T06:52:36.331914Z","end":"2026-05-27T06:52:36.588992Z","steps":["trace[454493917] 'agreement among raft nodes before linearized reading'  (duration: 256.917298ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:52:36.589084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.104091ms","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-27T06:52:36.589138Z","caller":"traceutil/trace.go:171","msg":"trace[1744339673] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25187; }","duration":"241.192573ms","start":"2026-05-27T06:52:36.347929Z","end":"2026-05-27T06:52:36.589121Z","steps":["trace[1744339673] 'agreement among raft nodes before linearized reading'  (duration: 241.013499ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-27T06:52:36.589286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.900099ms","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-27T06:52:36.589338Z","caller":"traceutil/trace.go:171","msg":"trace[1286236948] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25187; }","duration":"255.971981ms","start":"2026-05-27T06:52:36.33335Z","end":"2026-05-27T06:52:36.589322Z","steps":["trace[1286236948] 'agreement among raft nodes before linearized reading'  (duration: 255.801487ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:52:36.74389Z","caller":"traceutil/trace.go:171","msg":"trace[290313752] transaction","detail":"{read_only:false; response_revision:25188; number_of_response:1; }","duration":"151.119717ms","start":"2026-05-27T06:52:36.59275Z","end":"2026-05-27T06:52:36.74387Z","steps":["trace[290313752] 'process raft request'  (duration: 150.983835ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:52:36.747383Z","caller":"traceutil/trace.go:171","msg":"trace[2042175980] transaction","detail":"{read_only:false; response_revision:25190; number_of_response:1; }","duration":"153.801407ms","start":"2026-05-27T06:52:36.593574Z","end":"2026-05-27T06:52:36.747375Z","steps":["trace[2042175980] 'process raft request'  (duration: 153.761346ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:52:36.747412Z","caller":"traceutil/trace.go:171","msg":"trace[1730861396] transaction","detail":"{read_only:false; response_revision:25189; number_of_response:1; }","duration":"154.247016ms","start":"2026-05-27T06:52:36.593139Z","end":"2026-05-27T06:52:36.747386Z","steps":["trace[1730861396] 'process raft request'  (duration: 154.129714ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:52:36.747681Z","caller":"traceutil/trace.go:171","msg":"trace[488117450] transaction","detail":"{read_only:false; response_revision:25191; number_of_response:1; }","duration":"152.221678ms","start":"2026-05-27T06:52:36.595433Z","end":"2026-05-27T06:52:36.747655Z","steps":["trace[488117450] 'process raft request'  (duration: 151.923571ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:52:36.747747Z","caller":"traceutil/trace.go:171","msg":"trace[187912224] linearizableReadLoop","detail":"{readStateIndex:26000; appliedIndex:25996; }","duration":"115.268412ms","start":"2026-05-27T06:52:36.632457Z","end":"2026-05-27T06:52:36.747726Z","steps":["trace[187912224] 'read index received'  (duration: 111.260676ms)","trace[187912224] 'applied index is now lower than readState.Index'  (duration: 4.006796ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-27T06:52:36.748056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.576267ms","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-27T06:52:36.748104Z","caller":"traceutil/trace.go:171","msg":"trace[1469618249] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:25192; }","duration":"115.66609ms","start":"2026-05-27T06:52:36.632426Z","end":"2026-05-27T06:52:36.748093Z","steps":["trace[1469618249] 'agreement among raft nodes before linearized reading'  (duration: 115.570348ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:54:18.326578Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-0000000000006998.wal"}
{"level":"info","ts":"2026-05-27T06:54:26.105759Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":23399}
{"level":"info","ts":"2026-05-27T06:54:26.245218Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":23399,"took":"135.636375ms","hash":2115255308,"current-db-size-bytes":59662336,"current-db-size":"60 MB","current-db-size-in-use-bytes":36376576,"current-db-size-in-use":"36 MB"}
{"level":"info","ts":"2026-05-27T06:54:26.245321Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2115255308,"revision":23399,"compact-revision":20141}
{"level":"info","ts":"2026-05-27T06:56:20.921882Z","caller":"traceutil/trace.go:171","msg":"trace[904681515] transaction","detail":"{read_only:false; response_revision:27476; number_of_response:1; }","duration":"123.334373ms","start":"2026-05-27T06:56:20.798524Z","end":"2026-05-27T06:56:20.921859Z","steps":["trace[904681515] 'process raft request'  (duration: 123.191951ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T06:59:26.111207Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":26260}
{"level":"info","ts":"2026-05-27T06:59:26.252514Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":26260,"took":"137.032106ms","hash":477162826,"current-db-size-bytes":59662336,"current-db-size":"60 MB","current-db-size-in-use-bytes":33525760,"current-db-size-in-use":"34 MB"}
{"level":"info","ts":"2026-05-27T06:59:26.252601Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":477162826,"revision":26260,"compact-revision":23399}
{"level":"info","ts":"2026-05-27T06:59:57.914488Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"4594e5f716bad646","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-05-27T06:59:57.920005Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003}
{"level":"info","ts":"2026-05-27T06:59:57.92011Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003}
{"level":"info","ts":"2026-05-27T07:00:14.163641Z","caller":"traceutil/trace.go:171","msg":"trace[432150852] linearizableReadLoop","detail":"{readStateIndex:30203; appliedIndex:30202; }","duration":"152.427806ms","start":"2026-05-27T07:00:14.011183Z","end":"2026-05-27T07:00:14.163611Z","steps":["trace[432150852] 'read index received'  (duration: 73.954615ms)","trace[432150852] 'applied index is now lower than readState.Index'  (duration: 78.471381ms)"],"step_count":2}
{"level":"info","ts":"2026-05-27T07:00:14.163968Z","caller":"traceutil/trace.go:171","msg":"trace[335179907] transaction","detail":"{read_only:false; response_revision:29287; number_of_response:1; }","duration":"171.172029ms","start":"2026-05-27T07:00:13.992759Z","end":"2026-05-27T07:00:14.163931Z","steps":["trace[335179907] 'process raft request'  (duration: 92.493234ms)","trace[335179907] 'compare'  (duration: 77.940992ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-27T07:00:14.164101Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.899426ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12217"}
{"level":"info","ts":"2026-05-27T07:00:14.164165Z","caller":"traceutil/trace.go:171","msg":"trace[1974028349] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:29287; }","duration":"153.006448ms","start":"2026-05-27T07:00:14.011147Z","end":"2026-05-27T07:00:14.164153Z","steps":["trace[1974028349] 'agreement among raft nodes before linearized reading'  (duration: 152.571269ms)"],"step_count":1}
{"level":"info","ts":"2026-05-27T07:04:26.118376Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":28857}
{"level":"info","ts":"2026-05-27T07:04:26.252278Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":28857,"took":"129.458532ms","hash":213421190,"current-db-size-bytes":59662336,"current-db-size":"60 MB","current-db-size-in-use-bytes":30539776,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-05-27T07:04:26.252351Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":213421190,"revision":28857,"compact-revision":26260}
{"level":"info","ts":"2026-05-27T07:09:26.125269Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":31141}
{"level":"info","ts":"2026-05-27T07:09:26.261602Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":31141,"took":"130.259209ms","hash":3266991159,"current-db-size-bytes":59662336,"current-db-size":"60 MB","current-db-size-in-use-bytes":30523392,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-05-27T07:09:26.261677Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3266991159,"revision":31141,"compact-revision":28857}
{"level":"info","ts":"2026-05-27T07:14:26.131103Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":33440}
{"level":"info","ts":"2026-05-27T07:14:26.272542Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":33440,"took":"136.897585ms","hash":987963790,"current-db-size-bytes":59662336,"current-db-size":"60 MB","current-db-size-in-use-bytes":32223232,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-05-27T07:14:26.272615Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":987963790,"revision":33440,"compact-revision":31141}
{"level":"info","ts":"2026-05-27T07:19:26.139129Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":35736}
{"level":"info","ts":"2026-05-27T07:19:26.282885Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":35736,"took":"139.100305ms","hash":2245220229,"current-db-size-bytes":61190144,"current-db-size":"61 MB","current-db-size-in-use-bytes":32014336,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-05-27T07:19:26.282958Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2245220229,"revision":35736,"compact-revision":33440}
{"level":"info","ts":"2026-05-27T07:21:09.354817Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"4594e5f716bad646","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-05-27T07:21:09.360315Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004}
{"level":"info","ts":"2026-05-27T07:21:09.360384Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004}
{"level":"info","ts":"2026-05-27T07:24:26.159449Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":37962}
{"level":"info","ts":"2026-05-27T07:24:26.297812Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":37962,"took":"134.859585ms","hash":2663670555,"current-db-size-bytes":61190144,"current-db-size":"61 MB","current-db-size-in-use-bytes":31076352,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-05-27T07:24:26.297867Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2663670555,"revision":37962,"compact-revision":35736}