{"level":"warn","ts":"2026-08-19T09:08:43.330367Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-08-19T09:08:43.330452Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.182: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.182:2380","--initial-cluster=instance=https://199.204.45.182:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.182:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.182: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-08-19T09:08:43.33054Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-08-19T09:08:43.330552Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.182:2380"]}
{"level":"info","ts":"2026-08-19T09:08:43.330575Z","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-08-19T09:08:43.331199Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.182:2379"]}
{"level":"info","ts":"2026-08-19T09:08:43.331281Z","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.182:2380"],"listen-peer-urls":["https://199.204.45.182:2380"],"advertise-client-urls":["https://199.204.45.182:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.182:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.182: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-08-19T09:08:43.334829Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.324429ms"}
{"level":"info","ts":"2026-08-19T09:08:43.340106Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"e44ae1545340c14b","cluster-id":"7284b69afd367451"}
{"level":"info","ts":"2026-08-19T09:08:43.340245Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e44ae1545340c14b switched to configuration voters=()"}
{"level":"info","ts":"2026-08-19T09:08:43.340288Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e44ae1545340c14b became follower at term 0"}
{"level":"info","ts":"2026-08-19T09:08:43.34033Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft e44ae1545340c14b [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-08-19T09:08:43.340363Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e44ae1545340c14b became follower at term 1"}
{"level":"info","ts":"2026-08-19T09:08:43.340425Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e44ae1545340c14b switched to configuration voters=(16450208341214413131)"}
{"level":"warn","ts":"2026-08-19T09:08:43.345226Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-08-19T09:08:43.346756Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-08-19T09:08:43.348007Z","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-08-19T09:08:43.350441Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"e44ae1545340c14b","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-08-19T09:08:43.350777Z","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-08-19T09:08:43.35085Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"e44ae1545340c14b","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-08-19T09:08:43.35095Z","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-08-19T09:08:43.35111Z","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-08-19T09:08:43.351618Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e44ae1545340c14b switched to configuration voters=(16450208341214413131)"}
{"level":"info","ts":"2026-08-19T09:08:43.351787Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"7284b69afd367451","local-member-id":"e44ae1545340c14b","added-peer-id":"e44ae1545340c14b","added-peer-peer-urls":["https://199.204.45.182:2380"]}
{"level":"info","ts":"2026-08-19T09:08:43.355959Z","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-08-19T09:08:43.356084Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.182:2380"}
{"level":"info","ts":"2026-08-19T09:08:43.356134Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.182:2380"}
{"level":"info","ts":"2026-08-19T09:08:43.356392Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"e44ae1545340c14b","initial-advertise-peer-urls":["https://199.204.45.182:2380"],"listen-peer-urls":["https://199.204.45.182:2380"],"advertise-client-urls":["https://199.204.45.182:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.182:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-08-19T09:08:43.356444Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-08-19T09:08:43.940918Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e44ae1545340c14b is starting a new election at term 1"}
{"level":"info","ts":"2026-08-19T09:08:43.941Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e44ae1545340c14b became pre-candidate at term 1"}
{"level":"info","ts":"2026-08-19T09:08:43.941041Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e44ae1545340c14b received MsgPreVoteResp from e44ae1545340c14b at term 1"}
{"level":"info","ts":"2026-08-19T09:08:43.941068Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e44ae1545340c14b became candidate at term 2"}
{"level":"info","ts":"2026-08-19T09:08:43.941084Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e44ae1545340c14b received MsgVoteResp from e44ae1545340c14b at term 2"}
{"level":"info","ts":"2026-08-19T09:08:43.941107Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e44ae1545340c14b became leader at term 2"}
{"level":"info","ts":"2026-08-19T09:08:43.941126Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: e44ae1545340c14b elected leader e44ae1545340c14b at term 2"}
{"level":"info","ts":"2026-08-19T09:08:43.94248Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-08-19T09:08:43.943637Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-08-19T09:08:43.943677Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-08-19T09:08:43.94366Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"e44ae1545340c14b","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.182:2379]}","request-path":"/0/members/e44ae1545340c14b/attributes","cluster-id":"7284b69afd367451","publish-timeout":"7s"}
{"level":"info","ts":"2026-08-19T09:08:43.944177Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"7284b69afd367451","local-member-id":"e44ae1545340c14b","cluster-version":"3.5"}
{"level":"info","ts":"2026-08-19T09:08:43.944217Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-08-19T09:08:43.94425Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-08-19T09:08:43.94432Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-08-19T09:08:43.94437Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-08-19T09:08:43.947116Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-08-19T09:08:43.947174Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.182:2379"}
{"level":"info","ts":"2026-08-19T09:08:46.604815Z","caller":"traceutil/trace.go:171","msg":"trace[271442977] transaction","detail":"{read_only:false; response_revision:118; number_of_response:1; }","duration":"238.801745ms","start":"2026-08-19T09:08:46.365982Z","end":"2026-08-19T09:08:46.604783Z","steps":["trace[271442977] 'process raft request'  (duration: 233.163174ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:08:51.967923Z","caller":"traceutil/trace.go:171","msg":"trace[1973145096] transaction","detail":"{read_only:false; response_revision:286; number_of_response:1; }","duration":"169.148ms","start":"2026-08-19T09:08:51.798738Z","end":"2026-08-19T09:08:51.967886Z","steps":["trace[1973145096] 'process raft request'  (duration: 168.863433ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:08:52.286701Z","caller":"traceutil/trace.go:171","msg":"trace[1663402668] transaction","detail":"{read_only:false; response_revision:287; number_of_response:1; }","duration":"313.775512ms","start":"2026-08-19T09:08:51.97289Z","end":"2026-08-19T09:08:52.286666Z","steps":["trace[1663402668] 'process raft request'  (duration: 218.987222ms)","trace[1663402668] 'compare'  (duration: 94.635486ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-19T09:08:52.287566Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T09:08:51.972869Z","time spent":"314.021819ms","remote":"127.0.0.1:33000","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:264 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-08-19T09:08:52.311187Z","caller":"traceutil/trace.go:171","msg":"trace[935024910] linearizableReadLoop","detail":"{readStateIndex:298; appliedIndex:296; }","duration":"336.642186ms","start":"2026-08-19T09:08:51.974502Z","end":"2026-08-19T09:08:52.311145Z","steps":["trace[935024910] 'read index received'  (duration: 217.349728ms)","trace[935024910] 'applied index is now lower than readState.Index'  (duration: 119.291128ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-19T09:08:52.31143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.853102ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"}
{"level":"info","ts":"2026-08-19T09:08:52.311561Z","caller":"traceutil/trace.go:171","msg":"trace[758784673] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:288; }","duration":"337.022718ms","start":"2026-08-19T09:08:51.97449Z","end":"2026-08-19T09:08:52.311513Z","steps":["trace[758784673] 'agreement among raft nodes before linearized reading'  (duration: 336.782182ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:08:52.311561Z","caller":"traceutil/trace.go:171","msg":"trace[1684895357] transaction","detail":"{read_only:false; response_revision:288; number_of_response:1; }","duration":"337.405078ms","start":"2026-08-19T09:08:51.974096Z","end":"2026-08-19T09:08:52.311501Z","steps":["trace[1684895357] 'process raft request'  (duration: 336.923784ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:08:52.311613Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T09:08:51.974481Z","time spent":"337.116601ms","remote":"127.0.0.1:32846","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":374,"request content":"key:\"/registry/namespaces/kube-system\" "}
{"level":"warn","ts":"2026-08-19T09:08:52.311785Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T09:08:51.974076Z","time spent":"337.564362ms","remote":"127.0.0.1:33000","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:265 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-08-19T09:08:52.640637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.835542ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13928402303010655922 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/serviceaccounts/kube-system/resourcequota-controller\" mod_revision:0 > success:<request_put:<key:\"/registry/serviceaccounts/kube-system/resourcequota-controller\" value_size:129 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-08-19T09:08:52.640817Z","caller":"traceutil/trace.go:171","msg":"trace[1130038333] transaction","detail":"{read_only:false; response_revision:289; number_of_response:1; }","duration":"325.678853ms","start":"2026-08-19T09:08:52.315066Z","end":"2026-08-19T09:08:52.640744Z","steps":["trace[1130038333] 'process raft request'  (duration: 162.519523ms)","trace[1130038333] 'compare'  (duration: 162.648586ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-19T09:08:52.640976Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T09:08:52.315046Z","time spent":"325.874119ms","remote":"127.0.0.1:32934","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":199,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/serviceaccounts/kube-system/resourcequota-controller\" mod_revision:0 > success:<request_put:<key:\"/registry/serviceaccounts/kube-system/resourcequota-controller\" value_size:129 >> failure:<>"}
{"level":"info","ts":"2026-08-19T09:09:20.658367Z","caller":"traceutil/trace.go:171","msg":"trace[710422607] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"225.94346ms","start":"2026-08-19T09:09:20.432381Z","end":"2026-08-19T09:09:20.658324Z","steps":["trace[710422607] 'process raft request'  (duration: 221.525281ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:09:20.65865Z","caller":"traceutil/trace.go:171","msg":"trace[1093498126] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"201.134262ms","start":"2026-08-19T09:09:20.457481Z","end":"2026-08-19T09:09:20.658615Z","steps":["trace[1093498126] 'process raft request'  (duration: 200.825994ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:09:20.659002Z","caller":"traceutil/trace.go:171","msg":"trace[1358631981] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"193.470865ms","start":"2026-08-19T09:09:20.465509Z","end":"2026-08-19T09:09:20.658979Z","steps":["trace[1358631981] 'process raft request'  (duration: 193.023104ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:09:27.497678Z","caller":"traceutil/trace.go:171","msg":"trace[1596394977] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"277.443186ms","start":"2026-08-19T09:09:27.220189Z","end":"2026-08-19T09:09:27.497632Z","steps":["trace[1596394977] 'process raft request'  (duration: 276.926512ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:09:28.118979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"567.585232ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13928402303010656574 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:578 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-08-19T09:09:28.119182Z","caller":"traceutil/trace.go:171","msg":"trace[1838834254] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"558.58329ms","start":"2026-08-19T09:09:27.560579Z","end":"2026-08-19T09:09:28.119162Z","steps":["trace[1838834254] 'process raft request'  (duration: 558.525038ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:09:28.11925Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T09:09:27.560563Z","time spent":"558.661902ms","remote":"127.0.0.1:32962","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" mod_revision:0 > success:<request_put:<key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" value_size:2525 >> failure:<>"}
{"level":"info","ts":"2026-08-19T09:09:28.119323Z","caller":"traceutil/trace.go:171","msg":"trace[1758288370] linearizableReadLoop","detail":"{readStateIndex:618; appliedIndex:617; }","duration":"599.372186ms","start":"2026-08-19T09:09:27.51993Z","end":"2026-08-19T09:09:28.119302Z","steps":["trace[1758288370] 'read index received'  (duration: 31.307461ms)","trace[1758288370] 'applied index is now lower than readState.Index'  (duration: 568.063045ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-19T09:09:28.119536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"599.600583ms","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-08-19T09:09:28.119592Z","caller":"traceutil/trace.go:171","msg":"trace[1569592882] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:596; }","duration":"599.699336ms","start":"2026-08-19T09:09:27.519879Z","end":"2026-08-19T09:09:28.119579Z","steps":["trace[1569592882] 'agreement among raft nodes before linearized reading'  (duration: 599.49452ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:09:28.119626Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T09:09:27.519856Z","time spent":"599.760048ms","remote":"127.0.0.1:33000","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-08-19T09:09:28.119588Z","caller":"traceutil/trace.go:171","msg":"trace[2058409947] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"616.920748ms","start":"2026-08-19T09:09:27.50262Z","end":"2026-08-19T09:09:28.119541Z","steps":["trace[2058409947] 'process raft request'  (duration: 48.676599ms)","trace[2058409947] 'compare'  (duration: 567.424378ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-19T09:09:28.122876Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T09:09:27.502583Z","time spent":"617.302049ms","remote":"127.0.0.1:33000","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:578 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-08-19T09:09:29.331629Z","caller":"traceutil/trace.go:171","msg":"trace[2137792963] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"117.08348ms","start":"2026-08-19T09:09:29.214516Z","end":"2026-08-19T09:09:29.3316Z","steps":["trace[2137792963] 'process raft request'  (duration: 116.930116ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:09:50.401413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.891985ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-08-19T09:09:50.40152Z","caller":"traceutil/trace.go:171","msg":"trace[411334792] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:776; }","duration":"153.039359ms","start":"2026-08-19T09:09:50.248461Z","end":"2026-08-19T09:09:50.4015Z","steps":["trace[411334792] 'range keys from in-memory index tree'  (duration: 152.746881ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:09:50.40169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.554121ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"warn","ts":"2026-08-19T09:09:50.401675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.78103ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-cwlvx\" ","response":"range_response_count:1 size:3965"}
{"level":"info","ts":"2026-08-19T09:09:50.401746Z","caller":"traceutil/trace.go:171","msg":"trace[162135120] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:776; }","duration":"160.633754ms","start":"2026-08-19T09:09:50.2411Z","end":"2026-08-19T09:09:50.401734Z","steps":["trace[162135120] 'range keys from in-memory index tree'  (duration: 160.442579ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:09:50.401769Z","caller":"traceutil/trace.go:171","msg":"trace[342298118] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-cwlvx; range_end:; response_count:1; response_revision:776; }","duration":"169.938924ms","start":"2026-08-19T09:09:50.231807Z","end":"2026-08-19T09:09:50.401746Z","steps":["trace[342298118] 'range keys from in-memory index tree'  (duration: 169.591915ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:11:06.951639Z","caller":"traceutil/trace.go:171","msg":"trace[1503094081] linearizableReadLoop","detail":"{readStateIndex:1911; appliedIndex:1910; }","duration":"275.109019ms","start":"2026-08-19T09:11:06.676499Z","end":"2026-08-19T09:11:06.951608Z","steps":["trace[1503094081] 'read index received'  (duration: 274.812631ms)","trace[1503094081] 'applied index is now lower than readState.Index'  (duration: 294.588µs)"],"step_count":2}
{"level":"info","ts":"2026-08-19T09:11:06.951769Z","caller":"traceutil/trace.go:171","msg":"trace[1185841007] transaction","detail":"{read_only:false; response_revision:1838; number_of_response:1; }","duration":"323.679333ms","start":"2026-08-19T09:11:06.628049Z","end":"2026-08-19T09:11:06.951728Z","steps":["trace[1185841007] 'process raft request'  (duration: 323.312024ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:11:06.951942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.430707ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"}
{"level":"warn","ts":"2026-08-19T09:11:06.951998Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T09:11:06.62803Z","time spent":"323.839447ms","remote":"127.0.0.1:32924","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3732,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-42af54dc-1dbe-478c-9da1-04f86b05c245\" mod_revision:1797 > success:<request_put:<key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-42af54dc-1dbe-478c-9da1-04f86b05c245\" value_size:3632 >> failure:<request_range:<key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-42af54dc-1dbe-478c-9da1-04f86b05c245\" > >"}
{"level":"info","ts":"2026-08-19T09:11:06.952032Z","caller":"traceutil/trace.go:171","msg":"trace[1524300907] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1838; }","duration":"275.602392ms","start":"2026-08-19T09:11:06.676413Z","end":"2026-08-19T09:11:06.952016Z","steps":["trace[1524300907] 'agreement among raft nodes before linearized reading'  (duration: 275.330684ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:11:07.209561Z","caller":"traceutil/trace.go:171","msg":"trace[244506064] transaction","detail":"{read_only:false; response_revision:1840; number_of_response:1; }","duration":"252.569383ms","start":"2026-08-19T09:11:06.956957Z","end":"2026-08-19T09:11:07.209526Z","steps":["trace[244506064] 'process raft request'  (duration: 198.404568ms)","trace[244506064] 'compare'  (duration: 53.878767ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T09:11:07.209576Z","caller":"traceutil/trace.go:171","msg":"trace[1655358965] linearizableReadLoop","detail":"{readStateIndex:1914; appliedIndex:1912; }","duration":"222.275349ms","start":"2026-08-19T09:11:06.987268Z","end":"2026-08-19T09:11:07.209543Z","steps":["trace[1655358965] 'read index received'  (duration: 168.009162ms)","trace[1655358965] 'applied index is now lower than readState.Index'  (duration: 54.264677ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T09:11:07.209677Z","caller":"traceutil/trace.go:171","msg":"trace[609301619] transaction","detail":"{read_only:false; response_revision:1841; number_of_response:1; }","duration":"243.928281ms","start":"2026-08-19T09:11:06.965705Z","end":"2026-08-19T09:11:07.209633Z","steps":["trace[609301619] 'process raft request'  (duration: 243.723805ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:11:07.209898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.31787ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"warn","ts":"2026-08-19T09:11:07.209943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.655509ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-08-19T09:11:07.209997Z","caller":"traceutil/trace.go:171","msg":"trace[1298081533] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1841; }","duration":"222.446074ms","start":"2026-08-19T09:11:06.987532Z","end":"2026-08-19T09:11:07.209978Z","steps":["trace[1298081533] 'agreement among raft nodes before linearized reading'  (duration: 222.212878ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:11:07.210055Z","caller":"traceutil/trace.go:171","msg":"trace[1370108355] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1841; }","duration":"222.824124ms","start":"2026-08-19T09:11:06.987206Z","end":"2026-08-19T09:11:07.21003Z","steps":["trace[1370108355] 'agreement among raft nodes before linearized reading'  (duration: 222.510875ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:11:07.386343Z","caller":"traceutil/trace.go:171","msg":"trace[1004144144] transaction","detail":"{read_only:false; response_revision:1848; number_of_response:1; }","duration":"150.08392ms","start":"2026-08-19T09:11:07.236226Z","end":"2026-08-19T09:11:07.38631Z","steps":["trace[1004144144] 'process raft request'  (duration: 77.988534ms)","trace[1004144144] 'compare'  (duration: 71.928022ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T09:11:18.262134Z","caller":"traceutil/trace.go:171","msg":"trace[1934521491] transaction","detail":"{read_only:false; response_revision:1943; number_of_response:1; }","duration":"141.191632ms","start":"2026-08-19T09:11:18.120904Z","end":"2026-08-19T09:11:18.262096Z","steps":["trace[1934521491] 'process raft request'  (duration: 140.163465ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:11:51.731447Z","caller":"traceutil/trace.go:171","msg":"trace[754264355] transaction","detail":"{read_only:false; response_revision:2135; number_of_response:1; }","duration":"282.285591ms","start":"2026-08-19T09:11:51.449115Z","end":"2026-08-19T09:11:51.731401Z","steps":["trace[754264355] 'process raft request'  (duration: 282.010233ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:11:51.731397Z","caller":"traceutil/trace.go:171","msg":"trace[659890950] linearizableReadLoop","detail":"{readStateIndex:2217; appliedIndex:2216; }","duration":"208.436467ms","start":"2026-08-19T09:11:51.522891Z","end":"2026-08-19T09:11:51.731327Z","steps":["trace[659890950] 'read index received'  (duration: 208.086887ms)","trace[659890950] 'applied index is now lower than readState.Index'  (duration: 347.93µs)"],"step_count":2}
{"level":"warn","ts":"2026-08-19T09:11:51.731817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.677814ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-08-19T09:11:51.731866Z","caller":"traceutil/trace.go:171","msg":"trace[515290730] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2135; }","duration":"208.829188ms","start":"2026-08-19T09:11:51.523025Z","end":"2026-08-19T09:11:51.731855Z","steps":["trace[515290730] 'agreement among raft nodes before linearized reading'  (duration: 208.612822ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:11:51.731894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.971933ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-08-19T09:11:51.732047Z","caller":"traceutil/trace.go:171","msg":"trace[1916241014] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2135; }","duration":"209.174477ms","start":"2026-08-19T09:11:51.522827Z","end":"2026-08-19T09:11:51.732001Z","steps":["trace[1916241014] 'agreement among raft nodes before linearized reading'  (duration: 208.734526ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:11:51.944217Z","caller":"traceutil/trace.go:171","msg":"trace[1153844833] transaction","detail":"{read_only:false; response_revision:2136; number_of_response:1; }","duration":"207.940094ms","start":"2026-08-19T09:11:51.736223Z","end":"2026-08-19T09:11:51.944163Z","steps":["trace[1153844833] 'process raft request'  (duration: 151.835097ms)","trace[1153844833] 'compare'  (duration: 55.655355ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T09:11:51.944228Z","caller":"traceutil/trace.go:171","msg":"trace[1126755715] transaction","detail":"{read_only:false; response_revision:2138; number_of_response:1; }","duration":"110.043986ms","start":"2026-08-19T09:11:51.834153Z","end":"2026-08-19T09:11:51.944197Z","steps":["trace[1126755715] 'process raft request'  (duration: 109.990654ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:11:51.944426Z","caller":"traceutil/trace.go:171","msg":"trace[682912788] transaction","detail":"{read_only:false; response_revision:2137; number_of_response:1; }","duration":"208.025847ms","start":"2026-08-19T09:11:51.736309Z","end":"2026-08-19T09:11:51.944335Z","steps":["trace[682912788] 'process raft request'  (duration: 207.732859ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:11:52.137914Z","caller":"traceutil/trace.go:171","msg":"trace[71622061] transaction","detail":"{read_only:false; response_revision:2139; number_of_response:1; }","duration":"101.989549ms","start":"2026-08-19T09:11:52.03588Z","end":"2026-08-19T09:11:52.137869Z","steps":["trace[71622061] 'process raft request'  (duration: 81.100488ms)","trace[71622061] 'compare'  (duration: 20.355007ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T09:13:20.336761Z","caller":"traceutil/trace.go:171","msg":"trace[640081896] transaction","detail":"{read_only:false; response_revision:2808; number_of_response:1; }","duration":"110.928789ms","start":"2026-08-19T09:13:20.225799Z","end":"2026-08-19T09:13:20.336728Z","steps":["trace[640081896] 'process raft request'  (duration: 110.741984ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:15:25.419089Z","caller":"traceutil/trace.go:171","msg":"trace[489903586] transaction","detail":"{read_only:false; response_revision:3619; number_of_response:1; }","duration":"130.793389ms","start":"2026-08-19T09:15:25.288262Z","end":"2026-08-19T09:15:25.419055Z","steps":["trace[489903586] 'process raft request'  (duration: 114.837944ms)","trace[489903586] 'compare'  (duration: 15.714088ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T09:16:01.100085Z","caller":"traceutil/trace.go:171","msg":"trace[1625075888] transaction","detail":"{read_only:false; response_revision:3857; number_of_response:1; }","duration":"121.192828ms","start":"2026-08-19T09:16:00.978865Z","end":"2026-08-19T09:16:01.100057Z","steps":["trace[1625075888] 'process raft request'  (duration: 121.014282ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:17:24.981173Z","caller":"traceutil/trace.go:171","msg":"trace[1400944621] transaction","detail":"{read_only:false; response_revision:4917; number_of_response:1; }","duration":"118.764004ms","start":"2026-08-19T09:17:24.86238Z","end":"2026-08-19T09:17:24.981144Z","steps":["trace[1400944621] 'process raft request'  (duration: 44.399501ms)","trace[1400944621] 'compare'  (duration: 73.737205ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-19T09:17:29.600348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.091927ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-55f6a0fa-ad0e-4fc2-8cf9-c784d6e43907\" ","response":"range_response_count:1 size:3601"}
{"level":"warn","ts":"2026-08-19T09:17:29.6004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.234897ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.carvel.dev/secretimports/\" range_end:\"/registry/secretgen.carvel.dev/secretimports0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-08-19T09:17:29.600397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.838413ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-08-19T09:17:29.600422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.265341ms","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:5"}
{"level":"info","ts":"2026-08-19T09:17:29.600459Z","caller":"traceutil/trace.go:171","msg":"trace[212772360] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-55f6a0fa-ad0e-4fc2-8cf9-c784d6e43907; range_end:; response_count:1; response_revision:5101; }","duration":"275.281341ms","start":"2026-08-19T09:17:29.325156Z","end":"2026-08-19T09:17:29.600437Z","steps":["trace[212772360] 'range keys from in-memory index tree'  (duration: 274.803279ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:17:29.600518Z","caller":"traceutil/trace.go:171","msg":"trace[983596804] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:5101; }","duration":"285.413835ms","start":"2026-08-19T09:17:29.315084Z","end":"2026-08-19T09:17:29.600498Z","steps":["trace[983596804] 'count revisions from in-memory index tree'  (duration: 285.171699ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:17:29.600512Z","caller":"traceutil/trace.go:171","msg":"trace[1821084558] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secretimports/; range_end:/registry/secretgen.carvel.dev/secretimports0; response_count:0; response_revision:5101; }","duration":"215.3647ms","start":"2026-08-19T09:17:29.385116Z","end":"2026-08-19T09:17:29.600481Z","steps":["trace[1821084558] 'count revisions from in-memory index tree'  (duration: 215.157974ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:17:29.600544Z","caller":"traceutil/trace.go:171","msg":"trace[635413679] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5101; }","duration":"141.012307ms","start":"2026-08-19T09:17:29.459477Z","end":"2026-08-19T09:17:29.600489Z","steps":["trace[635413679] 'range keys from in-memory index tree'  (duration: 140.707679ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:17:29.600577Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.326668ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/monitoring/vector\" ","response":"range_response_count:1 size:894"}
{"level":"info","ts":"2026-08-19T09:17:29.600634Z","caller":"traceutil/trace.go:171","msg":"trace[1559709327] range","detail":"{range_begin:/registry/serviceaccounts/monitoring/vector; range_end:; response_count:1; response_revision:5101; }","duration":"273.41745ms","start":"2026-08-19T09:17:29.3272Z","end":"2026-08-19T09:17:29.600617Z","steps":["trace[1559709327] 'range keys from in-memory index tree'  (duration: 273.191784ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:17:29.600659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.665677ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-08-19T09:17:29.600745Z","caller":"traceutil/trace.go:171","msg":"trace[2119440857] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:5101; }","duration":"236.803219ms","start":"2026-08-19T09:17:29.363916Z","end":"2026-08-19T09:17:29.600719Z","steps":["trace[2119440857] 'count revisions from in-memory index tree'  (duration: 236.521822ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:17:29.600893Z","caller":"traceutil/trace.go:171","msg":"trace[1038674734] transaction","detail":"{read_only:false; response_revision:5102; number_of_response:1; }","duration":"101.757625ms","start":"2026-08-19T09:17:29.499104Z","end":"2026-08-19T09:17:29.600862Z","steps":["trace[1038674734] 'process raft request'  (duration: 69.125411ms)","trace[1038674734] 'compare'  (duration: 32.036117ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-19T09:17:29.601495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.766243ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:25 size:786936"}
{"level":"info","ts":"2026-08-19T09:17:29.601583Z","caller":"traceutil/trace.go:171","msg":"trace[1356464794] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:25; response_revision:5101; }","duration":"228.888785ms","start":"2026-08-19T09:17:29.372674Z","end":"2026-08-19T09:17:29.601563Z","steps":["trace[1356464794] 'range keys from in-memory index tree'  (duration: 227.364434ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:17:29.642103Z","caller":"traceutil/trace.go:171","msg":"trace[1227292042] linearizableReadLoop","detail":"{readStateIndex:5296; appliedIndex:5294; }","duration":"130.108671ms","start":"2026-08-19T09:17:29.511965Z","end":"2026-08-19T09:17:29.642074Z","steps":["trace[1227292042] 'read index received'  (duration: 56.281454ms)","trace[1227292042] 'applied index is now lower than readState.Index'  (duration: 73.825397ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T09:17:29.642304Z","caller":"traceutil/trace.go:171","msg":"trace[61192518] transaction","detail":"{read_only:false; response_revision:5103; number_of_response:1; }","duration":"139.590198ms","start":"2026-08-19T09:17:29.502678Z","end":"2026-08-19T09:17:29.642268Z","steps":["trace[61192518] 'process raft request'  (duration: 139.202948ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:17:29.642473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.462562ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:558"}
{"level":"info","ts":"2026-08-19T09:17:29.64252Z","caller":"traceutil/trace.go:171","msg":"trace[827125203] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:5103; }","duration":"130.587444ms","start":"2026-08-19T09:17:29.511915Z","end":"2026-08-19T09:17:29.642502Z","steps":["trace[827125203] 'agreement among raft nodes before linearized reading'  (duration: 130.322807ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:17:30.030161Z","caller":"traceutil/trace.go:171","msg":"trace[1784442254] transaction","detail":"{read_only:false; response_revision:5107; number_of_response:1; }","duration":"147.031261ms","start":"2026-08-19T09:17:29.883103Z","end":"2026-08-19T09:17:30.030135Z","steps":["trace[1784442254] 'process raft request'  (duration: 146.817135ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:17:30.077012Z","caller":"traceutil/trace.go:171","msg":"trace[380042638] linearizableReadLoop","detail":"{readStateIndex:5301; appliedIndex:5299; }","duration":"177.374621ms","start":"2026-08-19T09:17:29.899613Z","end":"2026-08-19T09:17:30.076987Z","steps":["trace[380042638] 'read index received'  (duration: 130.280375ms)","trace[380042638] 'applied index is now lower than readState.Index'  (duration: 47.092886ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T09:17:30.077131Z","caller":"traceutil/trace.go:171","msg":"trace[430632461] transaction","detail":"{read_only:false; response_revision:5108; number_of_response:1; }","duration":"182.326645ms","start":"2026-08-19T09:17:29.894794Z","end":"2026-08-19T09:17:30.077121Z","steps":["trace[430632461] 'process raft request'  (duration: 182.048837ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:17:30.07735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.553811ms","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-08-19T09:17:30.077403Z","caller":"traceutil/trace.go:171","msg":"trace[963110502] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5108; }","duration":"141.676595ms","start":"2026-08-19T09:17:29.935714Z","end":"2026-08-19T09:17:30.077391Z","steps":["trace[963110502] 'agreement among raft nodes before linearized reading'  (duration: 141.465339ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:17:30.077585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.969657ms","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-08-19T09:17:30.077619Z","caller":"traceutil/trace.go:171","msg":"trace[1093068554] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5108; }","duration":"178.05028ms","start":"2026-08-19T09:17:29.899562Z","end":"2026-08-19T09:17:30.077612Z","steps":["trace[1093068554] 'agreement among raft nodes before linearized reading'  (duration: 177.965177ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:17:31.717193Z","caller":"traceutil/trace.go:171","msg":"trace[837589922] linearizableReadLoop","detail":"{readStateIndex:5344; appliedIndex:5343; }","duration":"105.29695ms","start":"2026-08-19T09:17:31.611873Z","end":"2026-08-19T09:17:31.71717Z","steps":["trace[837589922] 'read index received'  (duration: 105.201628ms)","trace[837589922] 'applied index is now lower than readState.Index'  (duration: 94.452µs)"],"step_count":2}
{"level":"info","ts":"2026-08-19T09:17:31.71753Z","caller":"traceutil/trace.go:171","msg":"trace[584470110] transaction","detail":"{read_only:false; response_revision:5149; number_of_response:1; }","duration":"111.115568ms","start":"2026-08-19T09:17:31.606378Z","end":"2026-08-19T09:17:31.717494Z","steps":["trace[584470110] 'process raft request'  (duration: 110.627464ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:17:31.717846Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.962079ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-55f6a0fa-ad0e-4fc2-8cf9-c784d6e43907\" ","response":"range_response_count:1 size:3907"}
{"level":"info","ts":"2026-08-19T09:17:31.717894Z","caller":"traceutil/trace.go:171","msg":"trace[916269352] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-55f6a0fa-ad0e-4fc2-8cf9-c784d6e43907; range_end:; response_count:1; response_revision:5149; }","duration":"106.067971ms","start":"2026-08-19T09:17:31.611815Z","end":"2026-08-19T09:17:31.717883Z","steps":["trace[916269352] 'agreement among raft nodes before linearized reading'  (duration: 105.906267ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:17:34.896669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.220297ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13928402303010667125 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:5171 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:464 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >>","response":"size:16"}
{"level":"info","ts":"2026-08-19T09:17:34.896833Z","caller":"traceutil/trace.go:171","msg":"trace[1451904737] linearizableReadLoop","detail":"{readStateIndex:5417; appliedIndex:5416; }","duration":"175.888981ms","start":"2026-08-19T09:17:34.720923Z","end":"2026-08-19T09:17:34.896812Z","steps":["trace[1451904737] 'read index received'  (duration: 32.316334ms)","trace[1451904737] 'applied index is now lower than readState.Index'  (duration: 143.570567ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T09:17:34.896872Z","caller":"traceutil/trace.go:171","msg":"trace[2006157767] transaction","detail":"{read_only:false; response_revision:5219; number_of_response:1; }","duration":"178.0688ms","start":"2026-08-19T09:17:34.718759Z","end":"2026-08-19T09:17:34.896828Z","steps":["trace[2006157767] 'process raft request'  (duration: 34.517644ms)","trace[2006157767] 'compare'  (duration: 142.914859ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-19T09:17:34.897959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.023232ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:57 size:2225408"}
{"level":"info","ts":"2026-08-19T09:17:34.898013Z","caller":"traceutil/trace.go:171","msg":"trace[943597751] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:57; response_revision:5219; }","duration":"177.094324ms","start":"2026-08-19T09:17:34.720905Z","end":"2026-08-19T09:17:34.897999Z","steps":["trace[943597751] 'agreement among raft nodes before linearized reading'  (duration: 176.000604ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:17:34.921349Z","caller":"traceutil/trace.go:171","msg":"trace[1414525185] transaction","detail":"{read_only:false; response_revision:5220; number_of_response:1; }","duration":"192.058409ms","start":"2026-08-19T09:17:34.729267Z","end":"2026-08-19T09:17:34.921326Z","steps":["trace[1414525185] 'process raft request'  (duration: 191.806712ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:17:34.921953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.744347ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:27 size:809134"}
{"level":"info","ts":"2026-08-19T09:17:34.922063Z","caller":"traceutil/trace.go:171","msg":"trace[1284738268] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:27; response_revision:5220; }","duration":"165.934871ms","start":"2026-08-19T09:17:34.756103Z","end":"2026-08-19T09:17:34.922038Z","steps":["trace[1284738268] 'agreement among raft nodes before linearized reading'  (duration: 165.11822ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:17:40.295859Z","caller":"traceutil/trace.go:171","msg":"trace[78946781] transaction","detail":"{read_only:false; response_revision:5302; number_of_response:1; }","duration":"147.862582ms","start":"2026-08-19T09:17:40.147972Z","end":"2026-08-19T09:17:40.295835Z","steps":["trace[78946781] 'process raft request'  (duration: 147.736519ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:17:40.295881Z","caller":"traceutil/trace.go:171","msg":"trace[1686307283] transaction","detail":"{read_only:false; response_revision:5301; number_of_response:1; }","duration":"150.111433ms","start":"2026-08-19T09:17:40.145725Z","end":"2026-08-19T09:17:40.295836Z","steps":["trace[1686307283] 'process raft request'  (duration: 62.214044ms)","trace[1686307283] 'compare'  (duration: 87.522579ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-19T09:17:40.296182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.529543ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-08-19T09:17:40.296262Z","caller":"traceutil/trace.go:171","msg":"trace[2137271261] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5302; }","duration":"106.643728ms","start":"2026-08-19T09:17:40.189601Z","end":"2026-08-19T09:17:40.296244Z","steps":["trace[2137271261] 'agreement among raft nodes before linearized reading'  (duration: 106.418092ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:17:40.296042Z","caller":"traceutil/trace.go:171","msg":"trace[927720948] linearizableReadLoop","detail":"{readStateIndex:5502; appliedIndex:5500; }","duration":"106.145452ms","start":"2026-08-19T09:17:40.189629Z","end":"2026-08-19T09:17:40.295774Z","steps":["trace[927720948] 'read index received'  (duration: 18.305845ms)","trace[927720948] 'applied index is now lower than readState.Index'  (duration: 87.838127ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T09:17:42.584597Z","caller":"traceutil/trace.go:171","msg":"trace[573040711] linearizableReadLoop","detail":"{readStateIndex:5542; appliedIndex:5541; }","duration":"124.553722ms","start":"2026-08-19T09:17:42.460012Z","end":"2026-08-19T09:17:42.584566Z","steps":["trace[573040711] 'read index received'  (duration: 124.126881ms)","trace[573040711] 'applied index is now lower than readState.Index'  (duration: 425.691µs)"],"step_count":2}
{"level":"info","ts":"2026-08-19T09:17:42.584636Z","caller":"traceutil/trace.go:171","msg":"trace[996734875] transaction","detail":"{read_only:false; response_revision:5341; number_of_response:1; }","duration":"130.368099ms","start":"2026-08-19T09:17:42.454228Z","end":"2026-08-19T09:17:42.584596Z","steps":["trace[996734875] 'process raft request'  (duration: 130.02442ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:17:42.585024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.974684ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-19T09:17:42.585126Z","caller":"traceutil/trace.go:171","msg":"trace[1890161259] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5341; }","duration":"125.117787ms","start":"2026-08-19T09:17:42.459985Z","end":"2026-08-19T09:17:42.585103Z","steps":["trace[1890161259] 'agreement among raft nodes before linearized reading'  (duration: 124.740896ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:17:42.735589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.411032ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13928402303010667433 > lease_revoke:<id:414ba01947aef928>","response":"size:28"}
{"level":"info","ts":"2026-08-19T09:17:42.735789Z","caller":"traceutil/trace.go:171","msg":"trace[1242052942] linearizableReadLoop","detail":"{readStateIndex:5543; appliedIndex:5542; }","duration":"151.05588ms","start":"2026-08-19T09:17:42.584681Z","end":"2026-08-19T09:17:42.735737Z","steps":["trace[1242052942] 'read index received'  (duration: 14.500273ms)","trace[1242052942] 'applied index is now lower than readState.Index'  (duration: 136.553697ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T09:17:42.736001Z","caller":"traceutil/trace.go:171","msg":"trace[1413839433] transaction","detail":"{read_only:false; response_revision:5342; number_of_response:1; }","duration":"149.174918ms","start":"2026-08-19T09:17:42.586794Z","end":"2026-08-19T09:17:42.735969Z","steps":["trace[1413839433] 'process raft request'  (duration: 148.965692ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:17:42.736081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.413603ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-9kzd4\" ","response":"range_response_count:1 size:6531"}
{"level":"info","ts":"2026-08-19T09:17:42.736111Z","caller":"traceutil/trace.go:171","msg":"trace[36312827] range","detail":"{range_begin:/registry/pods/openstack/keepalived-9kzd4; range_end:; response_count:1; response_revision:5341; }","duration":"245.508746ms","start":"2026-08-19T09:17:42.490588Z","end":"2026-08-19T09:17:42.736097Z","steps":["trace[36312827] 'agreement among raft nodes before linearized reading'  (duration: 245.31164ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:17:42.736142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.360343ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-19T09:17:42.736236Z","caller":"traceutil/trace.go:171","msg":"trace[2082462347] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5342; }","duration":"149.476806ms","start":"2026-08-19T09:17:42.586736Z","end":"2026-08-19T09:17:42.736213Z","steps":["trace[2082462347] 'agreement among raft nodes before linearized reading'  (duration: 149.23088ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:17:43.487876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.981475ms","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-08-19T09:17:43.487995Z","caller":"traceutil/trace.go:171","msg":"trace[670373966] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5344; }","duration":"213.16826ms","start":"2026-08-19T09:17:43.2748Z","end":"2026-08-19T09:17:43.487969Z","steps":["trace[670373966] 'range keys from in-memory index tree'  (duration: 212.77829ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:17:43.488065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"407.977723ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"warn","ts":"2026-08-19T09:17:43.488079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"538.796365ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"}
{"level":"info","ts":"2026-08-19T09:17:43.488156Z","caller":"traceutil/trace.go:171","msg":"trace[297065521] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:5344; }","duration":"408.147168ms","start":"2026-08-19T09:17:43.079986Z","end":"2026-08-19T09:17:43.488133Z","steps":["trace[297065521] 'count revisions from in-memory index tree'  (duration: 407.801429ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:17:43.488184Z","caller":"traceutil/trace.go:171","msg":"trace[1607743026] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5344; }","duration":"538.960798ms","start":"2026-08-19T09:17:42.949196Z","end":"2026-08-19T09:17:43.488157Z","steps":["trace[1607743026] 'range keys from in-memory index tree'  (duration: 538.581818ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:17:43.488201Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T09:17:43.079964Z","time spent":"408.227041ms","remote":"127.0.0.1:32812","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":578,"response size":31,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true "}
{"level":"warn","ts":"2026-08-19T09:17:43.488235Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T09:17:42.949175Z","time spent":"539.048592ms","remote":"127.0.0.1:33000","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":579,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"warn","ts":"2026-08-19T09:17:43.488694Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"604.972616ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/memcached-memcached-6479589586-j6hp4\" ","response":"range_response_count:1 size:7818"}
{"level":"info","ts":"2026-08-19T09:17:43.488727Z","caller":"traceutil/trace.go:171","msg":"trace[1394713904] range","detail":"{range_begin:/registry/pods/openstack/memcached-memcached-6479589586-j6hp4; range_end:; response_count:1; response_revision:5344; }","duration":"605.047878ms","start":"2026-08-19T09:17:42.883668Z","end":"2026-08-19T09:17:43.488716Z","steps":["trace[1394713904] 'range keys from in-memory index tree'  (duration: 604.816751ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:17:43.488755Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T09:17:42.883645Z","time spent":"605.10336ms","remote":"127.0.0.1:32924","response type":"/etcdserverpb.KV/Range","request count":0,"request size":63,"response count":1,"response size":7841,"request content":"key:\"/registry/pods/openstack/memcached-memcached-6479589586-j6hp4\" "}
{"level":"info","ts":"2026-08-19T09:17:43.598074Z","caller":"traceutil/trace.go:171","msg":"trace[1067118198] transaction","detail":"{read_only:false; response_revision:5345; number_of_response:1; }","duration":"104.139429ms","start":"2026-08-19T09:17:43.493883Z","end":"2026-08-19T09:17:43.598022Z","steps":["trace[1067118198] 'process raft request'  (duration: 103.952945ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:17:43.601616Z","caller":"traceutil/trace.go:171","msg":"trace[1238991678] transaction","detail":"{read_only:false; response_revision:5347; number_of_response:1; }","duration":"101.978159ms","start":"2026-08-19T09:17:43.49961Z","end":"2026-08-19T09:17:43.601588Z","steps":["trace[1238991678] 'process raft request'  (duration: 101.903068ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:17:43.601989Z","caller":"traceutil/trace.go:171","msg":"trace[1155402171] transaction","detail":"{read_only:false; response_revision:5346; number_of_response:1; }","duration":"107.947762ms","start":"2026-08-19T09:17:43.493982Z","end":"2026-08-19T09:17:43.60193Z","steps":["trace[1155402171] 'process raft request'  (duration: 107.379256ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:17:52.061594Z","caller":"traceutil/trace.go:171","msg":"trace[925600212] transaction","detail":"{read_only:false; response_revision:5562; number_of_response:1; }","duration":"160.401773ms","start":"2026-08-19T09:17:51.90116Z","end":"2026-08-19T09:17:52.061561Z","steps":["trace[925600212] 'process raft request'  (duration: 103.726178ms)","trace[925600212] 'compare'  (duration: 56.54096ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T09:17:52.070259Z","caller":"traceutil/trace.go:171","msg":"trace[993295207] linearizableReadLoop","detail":"{readStateIndex:5769; appliedIndex:5767; }","duration":"113.779759ms","start":"2026-08-19T09:17:51.95646Z","end":"2026-08-19T09:17:52.07024Z","steps":["trace[993295207] 'read index received'  (duration: 48.44557ms)","trace[993295207] 'applied index is now lower than readState.Index'  (duration: 65.333259ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T09:17:52.07032Z","caller":"traceutil/trace.go:171","msg":"trace[264515616] transaction","detail":"{read_only:false; response_revision:5563; number_of_response:1; }","duration":"162.695534ms","start":"2026-08-19T09:17:51.907597Z","end":"2026-08-19T09:17:52.070293Z","steps":["trace[264515616] 'process raft request'  (duration: 162.535839ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:17:52.070419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.942254ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/policies/\" range_end:\"/registry/rabbitmq.com/policies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-19T09:17:52.070587Z","caller":"traceutil/trace.go:171","msg":"trace[1460236478] range","detail":"{range_begin:/registry/rabbitmq.com/policies/; range_end:/registry/rabbitmq.com/policies0; response_count:0; response_revision:5563; }","duration":"114.15989ms","start":"2026-08-19T09:17:51.956412Z","end":"2026-08-19T09:17:52.070572Z","steps":["trace[1460236478] 'agreement among raft nodes before linearized reading'  (duration: 113.949824ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:17:52.313871Z","caller":"traceutil/trace.go:171","msg":"trace[914674796] transaction","detail":"{read_only:false; response_revision:5565; number_of_response:1; }","duration":"236.880681ms","start":"2026-08-19T09:17:52.076963Z","end":"2026-08-19T09:17:52.313843Z","steps":["trace[914674796] 'process raft request'  (duration: 157.04013ms)","trace[914674796] 'compare'  (duration: 79.614345ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T09:17:52.314145Z","caller":"traceutil/trace.go:171","msg":"trace[954634220] transaction","detail":"{read_only:false; response_revision:5566; number_of_response:1; }","duration":"236.096501ms","start":"2026-08-19T09:17:52.078022Z","end":"2026-08-19T09:17:52.314118Z","steps":["trace[954634220] 'process raft request'  (duration: 235.771853ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:17:52.314521Z","caller":"traceutil/trace.go:171","msg":"trace[1568545714] transaction","detail":"{read_only:false; response_revision:5567; number_of_response:1; }","duration":"236.318067ms","start":"2026-08-19T09:17:52.078168Z","end":"2026-08-19T09:17:52.314486Z","steps":["trace[1568545714] 'process raft request'  (duration: 235.867195ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:17:52.314621Z","caller":"traceutil/trace.go:171","msg":"trace[570889886] transaction","detail":"{read_only:false; response_revision:5569; number_of_response:1; }","duration":"233.08761ms","start":"2026-08-19T09:17:52.0815Z","end":"2026-08-19T09:17:52.314587Z","steps":["trace[570889886] 'process raft request'  (duration: 232.997717ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:17:52.314775Z","caller":"traceutil/trace.go:171","msg":"trace[160511144] transaction","detail":"{read_only:false; response_revision:5568; number_of_response:1; }","duration":"233.342886ms","start":"2026-08-19T09:17:52.081397Z","end":"2026-08-19T09:17:52.31474Z","steps":["trace[160511144] 'process raft request'  (duration: 232.926706ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:17:52.318087Z","caller":"traceutil/trace.go:171","msg":"trace[502086354] transaction","detail":"{read_only:false; response_revision:5570; number_of_response:1; }","duration":"183.009733ms","start":"2026-08-19T09:17:52.13505Z","end":"2026-08-19T09:17:52.31806Z","steps":["trace[502086354] 'process raft request'  (duration: 182.855ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:18:44.009239Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2940}
{"level":"info","ts":"2026-08-19T09:18:44.107463Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2940,"took":"96.10207ms","hash":3141585252,"current-db-size-bytes":56451072,"current-db-size":"56 MB","current-db-size-in-use-bytes":33374208,"current-db-size-in-use":"33 MB"}
{"level":"info","ts":"2026-08-19T09:18:44.107536Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3141585252,"revision":2940,"compact-revision":-1}
{"level":"info","ts":"2026-08-19T09:23:44.016501Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6022}
{"level":"info","ts":"2026-08-19T09:23:44.113658Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6022,"took":"95.135535ms","hash":793022911,"current-db-size-bytes":56451072,"current-db-size":"56 MB","current-db-size-in-use-bytes":21848064,"current-db-size-in-use":"22 MB"}
{"level":"info","ts":"2026-08-19T09:23:44.113752Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":793022911,"revision":6022,"compact-revision":2940}
{"level":"info","ts":"2026-08-19T09:23:56.478384Z","caller":"traceutil/trace.go:171","msg":"trace[1231381456] linearizableReadLoop","detail":"{readStateIndex:8636; appliedIndex:8635; }","duration":"421.193554ms","start":"2026-08-19T09:23:56.057155Z","end":"2026-08-19T09:23:56.478348Z","steps":["trace[1231381456] 'read index received'  (duration: 420.904086ms)","trace[1231381456] 'applied index is now lower than readState.Index'  (duration: 288.168µs)"],"step_count":2}
{"level":"info","ts":"2026-08-19T09:23:56.478497Z","caller":"traceutil/trace.go:171","msg":"trace[224666784] transaction","detail":"{read_only:false; response_revision:8339; number_of_response:1; }","duration":"452.648375ms","start":"2026-08-19T09:23:56.025812Z","end":"2026-08-19T09:23:56.47846Z","steps":["trace[224666784] 'process raft request'  (duration: 452.338027ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:23:56.478652Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T09:23:56.025779Z","time spent":"452.79099ms","remote":"127.0.0.1:33000","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:8146 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:471 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"warn","ts":"2026-08-19T09:23:56.478756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"421.581764ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:529"}
{"level":"warn","ts":"2026-08-19T09:23:56.478783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"375.232039ms","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-08-19T09:23:56.478872Z","caller":"traceutil/trace.go:171","msg":"trace[1364738492] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8339; }","duration":"375.393023ms","start":"2026-08-19T09:23:56.103461Z","end":"2026-08-19T09:23:56.478854Z","steps":["trace[1364738492] 'agreement among raft nodes before linearized reading'  (duration: 375.113916ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:23:56.478872Z","caller":"traceutil/trace.go:171","msg":"trace[977861971] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:8339; }","duration":"421.747079ms","start":"2026-08-19T09:23:56.057097Z","end":"2026-08-19T09:23:56.478844Z","steps":["trace[977861971] 'agreement among raft nodes before linearized reading'  (duration: 421.41489ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:23:56.478944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T09:23:56.057075Z","time spent":"421.858591ms","remote":"127.0.0.1:33000","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":552,"request content":"key:\"/registry/leases/cert-manager/cert-manager-controller\" "}
{"level":"warn","ts":"2026-08-19T09:23:56.478941Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T09:23:56.103432Z","time spent":"375.492636ms","remote":"127.0.0.1:33000","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-08-19T09:23:56.598685Z","caller":"traceutil/trace.go:171","msg":"trace[104758728] transaction","detail":"{read_only:false; response_revision:8340; number_of_response:1; }","duration":"115.416375ms","start":"2026-08-19T09:23:56.483232Z","end":"2026-08-19T09:23:56.598649Z","steps":["trace[104758728] 'process raft request'  (duration: 114.697455ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:23:56.599041Z","caller":"traceutil/trace.go:171","msg":"trace[1930247459] linearizableReadLoop","detail":"{readStateIndex:8638; appliedIndex:8636; }","duration":"106.205896ms","start":"2026-08-19T09:23:56.4928Z","end":"2026-08-19T09:23:56.599006Z","steps":["trace[1930247459] 'read index received'  (duration: 105.140287ms)","trace[1930247459] 'applied index is now lower than readState.Index'  (duration: 1.064519ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T09:23:56.59918Z","caller":"traceutil/trace.go:171","msg":"trace[88581007] transaction","detail":"{read_only:false; response_revision:8341; number_of_response:1; }","duration":"115.23984ms","start":"2026-08-19T09:23:56.483906Z","end":"2026-08-19T09:23:56.599146Z","steps":["trace[88581007] 'process raft request'  (duration: 114.938273ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:23:56.599345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.371722ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-08-19T09:23:56.599398Z","caller":"traceutil/trace.go:171","msg":"trace[104867956] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8341; }","duration":"102.497505ms","start":"2026-08-19T09:23:56.496889Z","end":"2026-08-19T09:23:56.599386Z","steps":["trace[104867956] 'agreement among raft nodes before linearized reading'  (duration: 102.29402ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:23:56.59935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.529994ms","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-08-19T09:23:56.59952Z","caller":"traceutil/trace.go:171","msg":"trace[662270376] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8341; }","duration":"106.749791ms","start":"2026-08-19T09:23:56.492748Z","end":"2026-08-19T09:23:56.599497Z","steps":["trace[662270376] 'agreement among raft nodes before linearized reading'  (duration: 106.413852ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:24:07.789124Z","caller":"traceutil/trace.go:171","msg":"trace[129715281] transaction","detail":"{read_only:false; response_revision:8398; number_of_response:1; }","duration":"409.762664ms","start":"2026-08-19T09:24:07.379336Z","end":"2026-08-19T09:24:07.789098Z","steps":["trace[129715281] 'process raft request'  (duration: 409.585379ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:24:07.78929Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T09:24:07.379312Z","time spent":"409.886168ms","remote":"127.0.0.1:33000","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:8387 > 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-08-19T09:24:07.869945Z","caller":"traceutil/trace.go:171","msg":"trace[1733051361] linearizableReadLoop","detail":"{readStateIndex:8700; appliedIndex:8698; }","duration":"409.699063ms","start":"2026-08-19T09:24:07.460216Z","end":"2026-08-19T09:24:07.869915Z","steps":["trace[1733051361] 'read index received'  (duration: 328.794862ms)","trace[1733051361] 'applied index is now lower than readState.Index'  (duration: 80.903111ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T09:24:07.870003Z","caller":"traceutil/trace.go:171","msg":"trace[493892800] transaction","detail":"{read_only:false; response_revision:8399; number_of_response:1; }","duration":"482.052862ms","start":"2026-08-19T09:24:07.38792Z","end":"2026-08-19T09:24:07.869973Z","steps":["trace[493892800] 'process raft request'  (duration: 464.932798ms)","trace[493892800] 'compare'  (duration: 16.928378ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-19T09:24:07.870115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"409.885568ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-19T09:24:07.870161Z","caller":"traceutil/trace.go:171","msg":"trace[717254450] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8399; }","duration":"410.001371ms","start":"2026-08-19T09:24:07.460148Z","end":"2026-08-19T09:24:07.87015Z","steps":["trace[717254450] 'agreement among raft nodes before linearized reading'  (duration: 409.897198ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:24:07.870178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.364033ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"}
{"level":"warn","ts":"2026-08-19T09:24:07.870196Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T09:24:07.460125Z","time spent":"410.064933ms","remote":"127.0.0.1:60974","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-08-19T09:24:07.870205Z","caller":"traceutil/trace.go:171","msg":"trace[1980183472] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8399; }","duration":"112.437145ms","start":"2026-08-19T09:24:07.757759Z","end":"2026-08-19T09:24:07.870196Z","steps":["trace[1980183472] 'agreement among raft nodes before linearized reading'  (duration: 112.317482ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:24:07.870153Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T09:24:07.38789Z","time spent":"482.178916ms","remote":"127.0.0.1:33000","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:8388 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"info","ts":"2026-08-19T09:24:08.902753Z","caller":"traceutil/trace.go:171","msg":"trace[425549810] linearizableReadLoop","detail":"{readStateIndex:8704; appliedIndex:8703; }","duration":"229.300908ms","start":"2026-08-19T09:24:08.673426Z","end":"2026-08-19T09:24:08.902727Z","steps":["trace[425549810] 'read index received'  (duration: 229.027031ms)","trace[425549810] 'applied index is now lower than readState.Index'  (duration: 272.297µs)"],"step_count":2}
{"level":"info","ts":"2026-08-19T09:24:08.902832Z","caller":"traceutil/trace.go:171","msg":"trace[1986318314] transaction","detail":"{read_only:false; response_revision:8403; number_of_response:1; }","duration":"230.270344ms","start":"2026-08-19T09:24:08.672528Z","end":"2026-08-19T09:24:08.902798Z","steps":["trace[1986318314] 'process raft request'  (duration: 229.995636ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:24:08.90309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.546695ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"}
{"level":"warn","ts":"2026-08-19T09:24:08.903117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.273427ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-08-19T09:24:08.903178Z","caller":"traceutil/trace.go:171","msg":"trace[178617697] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8403; }","duration":"229.704789ms","start":"2026-08-19T09:24:08.673454Z","end":"2026-08-19T09:24:08.903159Z","steps":["trace[178617697] 'agreement among raft nodes before linearized reading'  (duration: 229.496074ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:24:08.903206Z","caller":"traceutil/trace.go:171","msg":"trace[639894902] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:8403; }","duration":"209.423721ms","start":"2026-08-19T09:24:08.693763Z","end":"2026-08-19T09:24:08.903187Z","steps":["trace[639894902] 'agreement among raft nodes before linearized reading'  (duration: 209.290687ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:24:08.903523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.057109ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"warn","ts":"2026-08-19T09:24:08.90365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.222902ms","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-08-19T09:24:08.903741Z","caller":"traceutil/trace.go:171","msg":"trace[1179120066] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8403; }","duration":"230.345497ms","start":"2026-08-19T09:24:08.673344Z","end":"2026-08-19T09:24:08.90369Z","steps":["trace[1179120066] 'agreement among raft nodes before linearized reading'  (duration: 229.536145ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:24:08.904056Z","caller":"traceutil/trace.go:171","msg":"trace[1548789175] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8403; }","duration":"230.265164ms","start":"2026-08-19T09:24:08.673384Z","end":"2026-08-19T09:24:08.903649Z","steps":["trace[1548789175] 'agreement among raft nodes before linearized reading'  (duration: 229.422951ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:24:38.579195Z","caller":"traceutil/trace.go:171","msg":"trace[939558898] linearizableReadLoop","detail":"{readStateIndex:8924; appliedIndex:8923; }","duration":"446.984963ms","start":"2026-08-19T09:24:38.132182Z","end":"2026-08-19T09:24:38.579167Z","steps":["trace[939558898] 'read index received'  (duration: 446.747097ms)","trace[939558898] 'applied index is now lower than readState.Index'  (duration: 236.396µs)"],"step_count":2}
{"level":"info","ts":"2026-08-19T09:24:38.579318Z","caller":"traceutil/trace.go:171","msg":"trace[1231477628] transaction","detail":"{read_only:false; response_revision:8615; number_of_response:1; }","duration":"474.499057ms","start":"2026-08-19T09:24:38.104765Z","end":"2026-08-19T09:24:38.579264Z","steps":["trace[1231477628] 'process raft request'  (duration: 474.204538ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:24:38.579514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"447.311631ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"warn","ts":"2026-08-19T09:24:38.579547Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T09:24:38.104745Z","time spent":"474.676681ms","remote":"127.0.0.1:33000","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:8604 > 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-08-19T09:24:38.579565Z","caller":"traceutil/trace.go:171","msg":"trace[479058993] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8615; }","duration":"447.430655ms","start":"2026-08-19T09:24:38.132123Z","end":"2026-08-19T09:24:38.579553Z","steps":["trace[479058993] 'agreement among raft nodes before linearized reading'  (duration: 447.223599ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:24:38.57961Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T09:24:38.132095Z","time spent":"447.506336ms","remote":"127.0.0.1:33000","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-08-19T09:24:38.579602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"411.955293ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"}
{"level":"info","ts":"2026-08-19T09:24:38.579669Z","caller":"traceutil/trace.go:171","msg":"trace[1562458994] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8615; }","duration":"412.094247ms","start":"2026-08-19T09:24:38.167558Z","end":"2026-08-19T09:24:38.579653Z","steps":["trace[1562458994] 'agreement among raft nodes before linearized reading'  (duration: 411.910222ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:24:38.579704Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T09:24:38.16753Z","time spent":"412.167989ms","remote":"127.0.0.1:33000","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":578,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"info","ts":"2026-08-19T09:24:38.719033Z","caller":"traceutil/trace.go:171","msg":"trace[1816025327] transaction","detail":"{read_only:false; response_revision:8616; number_of_response:1; }","duration":"134.001858ms","start":"2026-08-19T09:24:38.585004Z","end":"2026-08-19T09:24:38.719005Z","steps":["trace[1816025327] 'process raft request'  (duration: 133.045013ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:24:38.719193Z","caller":"traceutil/trace.go:171","msg":"trace[346641762] linearizableReadLoop","detail":"{readStateIndex:8926; appliedIndex:8924; }","duration":"131.321906ms","start":"2026-08-19T09:24:38.587835Z","end":"2026-08-19T09:24:38.719157Z","steps":["trace[346641762] 'read index received'  (duration: 130.164655ms)","trace[346641762] 'applied index is now lower than readState.Index'  (duration: 1.154141ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T09:24:38.719222Z","caller":"traceutil/trace.go:171","msg":"trace[2146382773] transaction","detail":"{read_only:false; response_revision:8617; number_of_response:1; }","duration":"131.409498ms","start":"2026-08-19T09:24:38.587764Z","end":"2026-08-19T09:24:38.719173Z","steps":["trace[2146382773] 'process raft request'  (duration: 131.190462ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:24:38.719404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.534052ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-08-19T09:24:38.719441Z","caller":"traceutil/trace.go:171","msg":"trace[139275725] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:8617; }","duration":"131.624573ms","start":"2026-08-19T09:24:38.587806Z","end":"2026-08-19T09:24:38.719431Z","steps":["trace[139275725] 'agreement among raft nodes before linearized reading'  (duration: 131.459679ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:24:51.203033Z","caller":"traceutil/trace.go:171","msg":"trace[1332995503] transaction","detail":"{read_only:false; response_revision:8725; number_of_response:1; }","duration":"306.287511ms","start":"2026-08-19T09:24:50.896713Z","end":"2026-08-19T09:24:51.203001Z","steps":["trace[1332995503] 'process raft request'  (duration: 254.345954ms)","trace[1332995503] 'compare'  (duration: 51.784062ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-19T09:24:51.203185Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T09:24:50.896693Z","time spent":"306.412976ms","remote":"127.0.0.1:32924","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4638,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/openstack/rook-ceph-detect-version-mwjt8\" mod_revision:8723 > success:<request_put:<key:\"/registry/pods/openstack/rook-ceph-detect-version-mwjt8\" value_size:4575 >> failure:<request_range:<key:\"/registry/pods/openstack/rook-ceph-detect-version-mwjt8\" > >"}
{"level":"info","ts":"2026-08-19T09:24:52.098652Z","caller":"traceutil/trace.go:171","msg":"trace[1155969057] linearizableReadLoop","detail":"{readStateIndex:9044; appliedIndex:9043; }","duration":"243.000849ms","start":"2026-08-19T09:24:51.855622Z","end":"2026-08-19T09:24:52.098622Z","steps":["trace[1155969057] 'read index received'  (duration: 242.880886ms)","trace[1155969057] 'applied index is now lower than readState.Index'  (duration: 118.103µs)"],"step_count":2}
{"level":"info","ts":"2026-08-19T09:24:52.098751Z","caller":"traceutil/trace.go:171","msg":"trace[1185256436] transaction","detail":"{read_only:false; response_revision:8730; number_of_response:1; }","duration":"243.83128ms","start":"2026-08-19T09:24:51.854887Z","end":"2026-08-19T09:24:52.098719Z","steps":["trace[1185256436] 'process raft request'  (duration: 243.532402ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:24:52.098961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.315727ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-mwjt8\" ","response":"range_response_count:1 size:4653"}
{"level":"info","ts":"2026-08-19T09:24:52.099004Z","caller":"traceutil/trace.go:171","msg":"trace[2055032456] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-mwjt8; range_end:; response_count:1; response_revision:8730; }","duration":"243.386618ms","start":"2026-08-19T09:24:51.855606Z","end":"2026-08-19T09:24:52.098992Z","steps":["trace[2055032456] 'agreement among raft nodes before linearized reading'  (duration: 243.178563ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:24:52.143401Z","caller":"traceutil/trace.go:171","msg":"trace[546065414] transaction","detail":"{read_only:false; response_revision:8731; number_of_response:1; }","duration":"277.030219ms","start":"2026-08-19T09:24:51.866343Z","end":"2026-08-19T09:24:52.143373Z","steps":["trace[546065414] 'process raft request'  (duration: 272.869567ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:24:52.143783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.869441ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-08-19T09:24:52.143862Z","caller":"traceutil/trace.go:171","msg":"trace[696621891] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:8733; }","duration":"210.008925ms","start":"2026-08-19T09:24:51.933837Z","end":"2026-08-19T09:24:52.143846Z","steps":["trace[696621891] 'agreement among raft nodes before linearized reading'  (duration: 209.84911ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:24:52.144098Z","caller":"traceutil/trace.go:171","msg":"trace[1877696932] transaction","detail":"{read_only:false; response_revision:8732; number_of_response:1; }","duration":"141.696316ms","start":"2026-08-19T09:24:52.002382Z","end":"2026-08-19T09:24:52.144078Z","steps":["trace[1877696932] 'process raft request'  (duration: 140.913875ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:24:52.1441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.910605ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"}
{"level":"info","ts":"2026-08-19T09:24:52.144197Z","caller":"traceutil/trace.go:171","msg":"trace[1660324101] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:8733; }","duration":"141.070299ms","start":"2026-08-19T09:24:52.003102Z","end":"2026-08-19T09:24:52.144172Z","steps":["trace[1660324101] 'agreement among raft nodes before linearized reading'  (duration: 140.817491ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:24:53.354552Z","caller":"traceutil/trace.go:171","msg":"trace[38241037] transaction","detail":"{read_only:false; response_revision:8740; number_of_response:1; }","duration":"110.285435ms","start":"2026-08-19T09:24:53.244229Z","end":"2026-08-19T09:24:53.354514Z","steps":["trace[38241037] 'process raft request'  (duration: 110.07972ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:25:14.234374Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002468.wal"}
{"level":"warn","ts":"2026-08-19T09:26:02.032618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.724ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13928402303010678622 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:9434 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-08-19T09:26:02.032783Z","caller":"traceutil/trace.go:171","msg":"trace[1718167503] transaction","detail":"{read_only:false; response_revision:9444; number_of_response:1; }","duration":"180.568418ms","start":"2026-08-19T09:26:01.852186Z","end":"2026-08-19T09:26:02.032755Z","steps":["trace[1718167503] 'process raft request'  (duration: 63.582361ms)","trace[1718167503] 'compare'  (duration: 116.444992ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T09:26:02.095017Z","caller":"traceutil/trace.go:171","msg":"trace[839926711] transaction","detail":"{read_only:false; response_revision:9445; number_of_response:1; }","duration":"213.580191ms","start":"2026-08-19T09:26:01.881402Z","end":"2026-08-19T09:26:02.094982Z","steps":["trace[839926711] 'process raft request'  (duration: 213.413787ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:26:32.149569Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"e44ae1545340c14b","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-08-19T09:26:32.156107Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-08-19T09:26:32.156263Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-08-19T09:28:44.02309Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8131}
{"level":"info","ts":"2026-08-19T09:28:44.090717Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8131,"took":"64.909277ms","hash":2762456036,"current-db-size-bytes":56451072,"current-db-size":"56 MB","current-db-size-in-use-bytes":29589504,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-08-19T09:28:44.090912Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2762456036,"revision":8131,"compact-revision":6022}
{"level":"info","ts":"2026-08-19T09:29:42.671003Z","caller":"traceutil/trace.go:171","msg":"trace[1787869318] transaction","detail":"{read_only:false; response_revision:11273; number_of_response:1; }","duration":"110.814454ms","start":"2026-08-19T09:29:42.560148Z","end":"2026-08-19T09:29:42.670962Z","steps":["trace[1787869318] 'process raft request'  (duration: 74.211423ms)","trace[1787869318] 'compare'  (duration: 36.383935ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T09:33:44.032029Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10723}
{"level":"info","ts":"2026-08-19T09:33:44.119027Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10723,"took":"83.717712ms","hash":3403470591,"current-db-size-bytes":56451072,"current-db-size":"56 MB","current-db-size-in-use-bytes":27844608,"current-db-size-in-use":"28 MB"}
{"level":"info","ts":"2026-08-19T09:33:44.119118Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3403470591,"revision":10723,"compact-revision":8131}
{"level":"info","ts":"2026-08-19T09:36:08.574087Z","caller":"traceutil/trace.go:171","msg":"trace[479719355] linearizableReadLoop","detail":"{readStateIndex:14348; appliedIndex:14347; }","duration":"113.270515ms","start":"2026-08-19T09:36:08.460754Z","end":"2026-08-19T09:36:08.574024Z","steps":["trace[479719355] 'read index received'  (duration: 113.031869ms)","trace[479719355] 'applied index is now lower than readState.Index'  (duration: 236.976µs)"],"step_count":2}
{"level":"info","ts":"2026-08-19T09:36:08.574174Z","caller":"traceutil/trace.go:171","msg":"trace[1628201550] transaction","detail":"{read_only:false; response_revision:13868; number_of_response:1; }","duration":"154.35336ms","start":"2026-08-19T09:36:08.419772Z","end":"2026-08-19T09:36:08.574125Z","steps":["trace[1628201550] 'process raft request'  (duration: 154.040131ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:36:08.574306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.536553ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-19T09:36:08.574357Z","caller":"traceutil/trace.go:171","msg":"trace[139143286] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:13868; }","duration":"113.634605ms","start":"2026-08-19T09:36:08.460709Z","end":"2026-08-19T09:36:08.574344Z","steps":["trace[139143286] 'agreement among raft nodes before linearized reading'  (duration: 113.526942ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:36:17.022312Z","caller":"traceutil/trace.go:171","msg":"trace[1209319119] transaction","detail":"{read_only:false; response_revision:13914; number_of_response:1; }","duration":"327.89314ms","start":"2026-08-19T09:36:16.694383Z","end":"2026-08-19T09:36:17.022277Z","steps":["trace[1209319119] 'process raft request'  (duration: 327.688456ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:36:17.022554Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T09:36:16.694367Z","time spent":"328.077335ms","remote":"127.0.0.1:33000","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:13900 > 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-08-19T09:37:50.169038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.759088ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13928402303010694483 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:14944 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:16"}
{"level":"info","ts":"2026-08-19T09:37:50.169208Z","caller":"traceutil/trace.go:171","msg":"trace[725993725] linearizableReadLoop","detail":"{readStateIndex:15469; appliedIndex:15468; }","duration":"212.658453ms","start":"2026-08-19T09:37:49.956531Z","end":"2026-08-19T09:37:50.169189Z","steps":["trace[725993725] 'read index received'  (duration: 71.342µs)","trace[725993725] 'applied index is now lower than readState.Index'  (duration: 212.585811ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T09:37:50.16931Z","caller":"traceutil/trace.go:171","msg":"trace[1013321949] transaction","detail":"{read_only:false; response_revision:14954; number_of_response:1; }","duration":"268.397386ms","start":"2026-08-19T09:37:49.900895Z","end":"2026-08-19T09:37:50.169293Z","steps":["trace[1013321949] 'process raft request'  (duration: 10.284939ms)","trace[1013321949] 'compare'  (duration: 257.626264ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-19T09:37:50.169467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.840788ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-19T09:37:50.169589Z","caller":"traceutil/trace.go:171","msg":"trace[864189635] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:14954; }","duration":"213.094244ms","start":"2026-08-19T09:37:49.956459Z","end":"2026-08-19T09:37:50.169554Z","steps":["trace[864189635] 'agreement among raft nodes before linearized reading'  (duration: 212.838627ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:37:50.329483Z","caller":"traceutil/trace.go:171","msg":"trace[1039708933] linearizableReadLoop","detail":"{readStateIndex:15470; appliedIndex:15469; }","duration":"160.192838ms","start":"2026-08-19T09:37:50.169255Z","end":"2026-08-19T09:37:50.329448Z","steps":["trace[1039708933] 'read index received'  (duration: 126.160344ms)","trace[1039708933] 'applied index is now lower than readState.Index'  (duration: 34.030934ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-19T09:37:50.329884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.485775ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-08-19T09:37:50.330016Z","caller":"traceutil/trace.go:171","msg":"trace[1231919476] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:14955; }","duration":"224.680339ms","start":"2026-08-19T09:37:50.105304Z","end":"2026-08-19T09:37:50.329985Z","steps":["trace[1231919476] 'agreement among raft nodes before linearized reading'  (duration: 224.255347ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:37:50.33025Z","caller":"traceutil/trace.go:171","msg":"trace[1776254076] transaction","detail":"{read_only:false; response_revision:14955; number_of_response:1; }","duration":"330.47496ms","start":"2026-08-19T09:37:49.99975Z","end":"2026-08-19T09:37:50.330225Z","steps":["trace[1776254076] 'process raft request'  (duration: 295.758168ms)","trace[1776254076] 'compare'  (duration: 33.812308ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-19T09:37:50.330257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"373.474749ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:668"}
{"level":"info","ts":"2026-08-19T09:37:50.330512Z","caller":"traceutil/trace.go:171","msg":"trace[1988040015] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:14955; }","duration":"373.760937ms","start":"2026-08-19T09:37:49.956719Z","end":"2026-08-19T09:37:50.33048Z","steps":["trace[1988040015] 'agreement among raft nodes before linearized reading'  (duration: 373.041347ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:37:50.330626Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T09:37:49.956629Z","time spent":"373.979762ms","remote":"127.0.0.1:32898","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":691,"request content":"key:\"/registry/services/endpoints/openstack/nova-api\" "}
{"level":"warn","ts":"2026-08-19T09:37:50.33037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"373.777977ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5523"}
{"level":"warn","ts":"2026-08-19T09:37:50.330785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.241803ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-2k9g4\" ","response":"range_response_count:1 size:9799"}
{"level":"info","ts":"2026-08-19T09:37:50.330834Z","caller":"traceutil/trace.go:171","msg":"trace[1375039097] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:14955; }","duration":"374.286561ms","start":"2026-08-19T09:37:49.956532Z","end":"2026-08-19T09:37:50.330818Z","steps":["trace[1375039097] 'agreement among raft nodes before linearized reading'  (duration: 373.745736ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:37:50.330888Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T09:37:49.956505Z","time spent":"374.369882ms","remote":"127.0.0.1:32962","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":5546,"request content":"key:\"/registry/jobs/openstack/nova-db-sync\" "}
{"level":"info","ts":"2026-08-19T09:37:50.330927Z","caller":"traceutil/trace.go:171","msg":"trace[914790677] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-2k9g4; range_end:; response_count:1; response_revision:14955; }","duration":"299.372567ms","start":"2026-08-19T09:37:50.031467Z","end":"2026-08-19T09:37:50.33084Z","steps":["trace[914790677] 'agreement among raft nodes before linearized reading'  (duration: 299.052179ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:37:50.330558Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T09:37:49.999725Z","time spent":"330.592174ms","remote":"127.0.0.1:33000","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:14946 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-08-19T09:37:50.334285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.99432ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-08-19T09:37:50.334344Z","caller":"traceutil/trace.go:171","msg":"trace[610906295] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:14955; }","duration":"151.102262ms","start":"2026-08-19T09:37:50.183227Z","end":"2026-08-19T09:37:50.334329Z","steps":["trace[610906295] 'agreement among raft nodes before linearized reading'  (duration: 150.99582ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:38:44.040624Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12829}
{"level":"info","ts":"2026-08-19T09:38:44.121789Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12829,"took":"78.108931ms","hash":255453879,"current-db-size-bytes":56451072,"current-db-size":"56 MB","current-db-size-in-use-bytes":30588928,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-08-19T09:38:44.121859Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":255453879,"revision":12829,"compact-revision":10723}
{"level":"info","ts":"2026-08-19T09:40:25.862413Z","caller":"traceutil/trace.go:171","msg":"trace[983924340] transaction","detail":"{read_only:false; response_revision:16084; number_of_response:1; }","duration":"104.384174ms","start":"2026-08-19T09:40:25.757994Z","end":"2026-08-19T09:40:25.862379Z","steps":["trace[983924340] 'process raft request'  (duration: 104.155078ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:40:26.179883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.725779ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephnfses/\" range_end:\"/registry/ceph.rook.io/cephnfses0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-19T09:40:26.180021Z","caller":"traceutil/trace.go:171","msg":"trace[767829258] range","detail":"{range_begin:/registry/ceph.rook.io/cephnfses/; range_end:/registry/ceph.rook.io/cephnfses0; response_count:0; response_revision:16084; }","duration":"102.951464ms","start":"2026-08-19T09:40:26.077039Z","end":"2026-08-19T09:40:26.179991Z","steps":["trace[767829258] 'count revisions from in-memory index tree'  (duration: 102.585185ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:41:22.219262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"545.709995ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/neutron-ks-user\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-19T09:41:22.219379Z","caller":"traceutil/trace.go:171","msg":"trace[1744116505] range","detail":"{range_begin:/registry/jobs/openstack/neutron-ks-user; range_end:; response_count:0; response_revision:16605; }","duration":"545.875018ms","start":"2026-08-19T09:41:21.673481Z","end":"2026-08-19T09:41:22.219356Z","steps":["trace[1744116505] 'range keys from in-memory index tree'  (duration: 545.62236ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:41:22.219427Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T09:41:21.673466Z","time spent":"545.951569ms","remote":"127.0.0.1:32962","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":0,"response size":29,"request content":"key:\"/registry/jobs/openstack/neutron-ks-user\" "}
{"level":"warn","ts":"2026-08-19T09:41:22.219447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.473165ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/neutron-rabbit-init\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-19T09:41:22.219534Z","caller":"traceutil/trace.go:171","msg":"trace[1461332065] range","detail":"{range_begin:/registry/jobs/openstack/neutron-rabbit-init; range_end:; response_count:0; response_revision:16605; }","duration":"332.610228ms","start":"2026-08-19T09:41:21.886905Z","end":"2026-08-19T09:41:22.219515Z","steps":["trace[1461332065] 'range keys from in-memory index tree'  (duration: 332.410703ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:41:22.219587Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T09:41:21.886894Z","time spent":"332.6799ms","remote":"127.0.0.1:32962","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":0,"response size":29,"request content":"key:\"/registry/jobs/openstack/neutron-rabbit-init\" "}
{"level":"warn","ts":"2026-08-19T09:41:22.21957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.739706ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-08-19T09:41:22.219727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"710.153518ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"}
{"level":"info","ts":"2026-08-19T09:41:22.219798Z","caller":"traceutil/trace.go:171","msg":"trace[1911233828] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:16605; }","duration":"201.992754ms","start":"2026-08-19T09:41:22.017776Z","end":"2026-08-19T09:41:22.219768Z","steps":["trace[1911233828] 'range keys from in-memory index tree'  (duration: 201.705106ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:41:22.219849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"699.599911ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/neutron-server\" ","response":"range_response_count:1 size:701"}
{"level":"info","ts":"2026-08-19T09:41:22.21985Z","caller":"traceutil/trace.go:171","msg":"trace[469688319] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:16605; }","duration":"710.376964ms","start":"2026-08-19T09:41:21.50945Z","end":"2026-08-19T09:41:22.219827Z","steps":["trace[469688319] 'range keys from in-memory index tree'  (duration: 709.911252ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:41:22.219964Z","caller":"traceutil/trace.go:171","msg":"trace[1804382489] range","detail":"{range_begin:/registry/services/endpoints/openstack/neutron-server; range_end:; response_count:1; response_revision:16605; }","duration":"699.733364ms","start":"2026-08-19T09:41:21.520186Z","end":"2026-08-19T09:41:22.219919Z","steps":["trace[1804382489] 'range keys from in-memory index tree'  (duration: 699.451208ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:41:22.219973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"424.062241ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-08-19T09:41:22.219981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"761.022868ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-08-19T09:41:22.21998Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T09:41:21.509394Z","time spent":"710.570589ms","remote":"127.0.0.1:33000","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":517,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"info","ts":"2026-08-19T09:41:22.220034Z","caller":"traceutil/trace.go:171","msg":"trace[1079124829] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:16605; }","duration":"424.185225ms","start":"2026-08-19T09:41:21.795831Z","end":"2026-08-19T09:41:22.220016Z","steps":["trace[1079124829] 'count revisions from in-memory index tree'  (duration: 423.952357ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:41:22.220061Z","caller":"traceutil/trace.go:171","msg":"trace[798738842] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:16605; }","duration":"761.138411ms","start":"2026-08-19T09:41:21.458904Z","end":"2026-08-19T09:41:22.220042Z","steps":["trace[798738842] 'range keys from in-memory index tree'  (duration: 760.912336ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:41:22.220076Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T09:41:21.795807Z","time spent":"424.251856ms","remote":"127.0.0.1:48116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true "}
{"level":"warn","ts":"2026-08-19T09:41:22.220102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"536.384851ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-08-19T09:41:22.220107Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T09:41:21.458887Z","time spent":"761.207224ms","remote":"127.0.0.1:60974","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-08-19T09:41:22.220087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"333.086012ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/neutron-ks-user\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-19T09:41:22.220155Z","caller":"traceutil/trace.go:171","msg":"trace[1771281007] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:16605; }","duration":"536.444432ms","start":"2026-08-19T09:41:21.683685Z","end":"2026-08-19T09:41:22.220129Z","steps":["trace[1771281007] 'count revisions from in-memory index tree'  (duration: 536.33335ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:41:22.220139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"333.498493ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/neutron-ks-endpoints\" ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-08-19T09:41:22.220116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"700.859756ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/neutron-rabbit-init\" ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-08-19T09:41:22.220205Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T09:41:21.683674Z","time spent":"536.519514ms","remote":"127.0.0.1:43888","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true "}
{"level":"warn","ts":"2026-08-19T09:41:22.220221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"472.724392ms","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-08-19T09:41:22.220221Z","caller":"traceutil/trace.go:171","msg":"trace[233265687] range","detail":"{range_begin:/registry/jobs/openstack/neutron-ks-endpoints; range_end:; response_count:0; response_revision:16605; }","duration":"333.619876ms","start":"2026-08-19T09:41:21.886577Z","end":"2026-08-19T09:41:22.220197Z","steps":["trace[233265687] 'range keys from in-memory index tree'  (duration: 333.37836ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:41:22.220261Z","caller":"traceutil/trace.go:171","msg":"trace[111745249] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:16605; }","duration":"472.819004ms","start":"2026-08-19T09:41:21.747432Z","end":"2026-08-19T09:41:22.220251Z","steps":["trace[111745249] 'count revisions from in-memory index tree'  (duration: 472.574198ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:41:22.220272Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T09:41:21.886554Z","time spent":"333.706688ms","remote":"127.0.0.1:32962","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":0,"response size":29,"request content":"key:\"/registry/jobs/openstack/neutron-ks-endpoints\" "}
{"level":"warn","ts":"2026-08-19T09:41:22.220302Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T09:41:21.747389Z","time spent":"472.900347ms","remote":"127.0.0.1:32830","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":178,"response size":32,"request content":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true "}
{"level":"warn","ts":"2026-08-19T09:41:22.220321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"380.294084ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/neutron-l3-agent-default-vs2cq\" ","response":"range_response_count:1 size:18679"}
{"level":"info","ts":"2026-08-19T09:41:22.220355Z","caller":"traceutil/trace.go:171","msg":"trace[464162567] range","detail":"{range_begin:/registry/pods/openstack/neutron-l3-agent-default-vs2cq; range_end:; response_count:1; response_revision:16605; }","duration":"380.357235ms","start":"2026-08-19T09:41:21.839989Z","end":"2026-08-19T09:41:22.220346Z","steps":["trace[464162567] 'range keys from in-memory index tree'  (duration: 380.023577ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:41:22.220395Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T09:41:21.839971Z","time spent":"380.414867ms","remote":"127.0.0.1:32924","response type":"/etcdserverpb.KV/Range","request count":0,"request size":57,"response count":1,"response size":18702,"request content":"key:\"/registry/pods/openstack/neutron-l3-agent-default-vs2cq\" "}
{"level":"warn","ts":"2026-08-19T09:41:22.220024Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T09:41:21.520162Z","time spent":"699.851269ms","remote":"127.0.0.1:32898","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":724,"request content":"key:\"/registry/services/endpoints/openstack/neutron-server\" "}
{"level":"warn","ts":"2026-08-19T09:41:22.219872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"546.969728ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/neutron-rabbit-init\" ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-08-19T09:41:22.22051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"542.855095ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/neutron-metadata-agent-default-rt6pc\" ","response":"range_response_count:1 size:14284"}
{"level":"warn","ts":"2026-08-19T09:41:22.220544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"540.744299ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-2k9sf\" ","response":"range_response_count:1 size:22133"}
{"level":"warn","ts":"2026-08-19T09:41:22.220552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"733.683506ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-2k9sf\" ","response":"range_response_count:1 size:22133"}
{"level":"info","ts":"2026-08-19T09:41:22.22056Z","caller":"traceutil/trace.go:171","msg":"trace[1687958228] range","detail":"{range_begin:/registry/jobs/openstack/neutron-rabbit-init; range_end:; response_count:0; response_revision:16605; }","duration":"547.663786ms","start":"2026-08-19T09:41:21.67288Z","end":"2026-08-19T09:41:22.220544Z","steps":["trace[1687958228] 'range keys from in-memory index tree'  (duration: 546.932386ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:41:22.220583Z","caller":"traceutil/trace.go:171","msg":"trace[1371830452] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-2k9sf; range_end:; response_count:1; response_revision:16605; }","duration":"540.79761ms","start":"2026-08-19T09:41:21.679774Z","end":"2026-08-19T09:41:22.220572Z","steps":["trace[1371830452] 'range keys from in-memory index tree'  (duration: 540.603805ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:41:22.220581Z","caller":"traceutil/trace.go:171","msg":"trace[1298606610] range","detail":"{range_begin:/registry/pods/openstack/neutron-metadata-agent-default-rt6pc; range_end:; response_count:1; response_revision:16605; }","duration":"542.954489ms","start":"2026-08-19T09:41:21.677606Z","end":"2026-08-19T09:41:22.220561Z","steps":["trace[1298606610] 'range keys from in-memory index tree'  (duration: 542.693752ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:41:22.2206Z","caller":"traceutil/trace.go:171","msg":"trace[1815701966] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-2k9sf; range_end:; response_count:1; response_revision:16605; }","duration":"733.732887ms","start":"2026-08-19T09:41:21.486854Z","end":"2026-08-19T09:41:22.220587Z","steps":["trace[1815701966] 'range keys from in-memory index tree'  (duration: 733.267785ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:41:22.220613Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T09:41:21.672875Z","time spent":"547.722068ms","remote":"127.0.0.1:32962","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":0,"response size":29,"request content":"key:\"/registry/jobs/openstack/neutron-rabbit-init\" "}
{"level":"warn","ts":"2026-08-19T09:41:22.220627Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T09:41:21.679764Z","time spent":"540.855013ms","remote":"127.0.0.1:32924","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":22156,"request content":"key:\"/registry/pods/openstack/nova-compute-default-2k9sf\" "}
{"level":"warn","ts":"2026-08-19T09:41:22.219888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"583.020067ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/neutron-dhcp-agent-default-g7kz5\" ","response":"range_response_count:1 size:18654"}
{"level":"warn","ts":"2026-08-19T09:41:22.220642Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T09:41:21.486832Z","time spent":"733.80266ms","remote":"127.0.0.1:32924","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":22156,"request content":"key:\"/registry/pods/openstack/nova-compute-default-2k9sf\" "}
{"level":"warn","ts":"2026-08-19T09:41:22.220641Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T09:41:21.677593Z","time spent":"543.035012ms","remote":"127.0.0.1:32924","response type":"/etcdserverpb.KV/Range","request count":0,"request size":63,"response count":1,"response size":14307,"request content":"key:\"/registry/pods/openstack/neutron-metadata-agent-default-rt6pc\" "}
{"level":"info","ts":"2026-08-19T09:41:22.220686Z","caller":"traceutil/trace.go:171","msg":"trace[269243190] range","detail":"{range_begin:/registry/pods/openstack/neutron-dhcp-agent-default-g7kz5; range_end:; response_count:1; response_revision:16605; }","duration":"583.870901ms","start":"2026-08-19T09:41:21.636794Z","end":"2026-08-19T09:41:22.220665Z","steps":["trace[269243190] 'range keys from in-memory index tree'  (duration: 582.808592ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:41:22.220243Z","caller":"traceutil/trace.go:171","msg":"trace[1650013032] range","detail":"{range_begin:/registry/jobs/openstack/neutron-rabbit-init; range_end:; response_count:0; response_revision:16605; }","duration":"701.01676ms","start":"2026-08-19T09:41:21.519199Z","end":"2026-08-19T09:41:22.220216Z","steps":["trace[1650013032] 'range keys from in-memory index tree'  (duration: 700.794714ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:41:22.220761Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T09:41:21.636763Z","time spent":"583.978673ms","remote":"127.0.0.1:32924","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":18677,"request content":"key:\"/registry/pods/openstack/neutron-dhcp-agent-default-g7kz5\" "}
{"level":"warn","ts":"2026-08-19T09:41:22.220817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"725.714729ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"}
{"level":"warn","ts":"2026-08-19T09:41:22.220136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"546.325021ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/neutron-db-sync\" ","response":"range_response_count:1 size:5311"}
{"level":"info","ts":"2026-08-19T09:41:22.220861Z","caller":"traceutil/trace.go:171","msg":"trace[1718047672] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:16605; }","duration":"725.813883ms","start":"2026-08-19T09:41:21.495037Z","end":"2026-08-19T09:41:22.220851Z","steps":["trace[1718047672] 'range keys from in-memory index tree'  (duration: 725.533325ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:41:22.22089Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T09:41:21.495005Z","time spent":"725.879555ms","remote":"127.0.0.1:33000","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-08-19T09:41:22.220777Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T09:41:21.519191Z","time spent":"701.573635ms","remote":"127.0.0.1:32962","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":0,"response size":29,"request content":"key:\"/registry/jobs/openstack/neutron-rabbit-init\" "}
{"level":"info","ts":"2026-08-19T09:41:22.220899Z","caller":"traceutil/trace.go:171","msg":"trace[37184552] range","detail":"{range_begin:/registry/jobs/openstack/neutron-db-sync; range_end:; response_count:1; response_revision:16605; }","duration":"547.139072ms","start":"2026-08-19T09:41:21.673742Z","end":"2026-08-19T09:41:22.220881Z","steps":["trace[37184552] 'range keys from in-memory index tree'  (duration: 546.074464ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:41:22.220164Z","caller":"traceutil/trace.go:171","msg":"trace[1777564083] range","detail":"{range_begin:/registry/jobs/openstack/neutron-ks-user; range_end:; response_count:0; response_revision:16605; }","duration":"333.161583ms","start":"2026-08-19T09:41:21.886988Z","end":"2026-08-19T09:41:22.220149Z","steps":["trace[1777564083] 'range keys from in-memory index tree'  (duration: 332.980468ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:41:22.220973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T09:41:21.673705Z","time spent":"547.250126ms","remote":"127.0.0.1:32962","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":5334,"request content":"key:\"/registry/jobs/openstack/neutron-db-sync\" "}
{"level":"warn","ts":"2026-08-19T09:41:22.221018Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T09:41:21.886931Z","time spent":"334.070419ms","remote":"127.0.0.1:32962","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":0,"response size":29,"request content":"key:\"/registry/jobs/openstack/neutron-ks-user\" "}
{"level":"warn","ts":"2026-08-19T09:41:22.219605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"547.457232ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/neutron-ks-endpoints\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-19T09:41:22.221103Z","caller":"traceutil/trace.go:171","msg":"trace[2036593902] range","detail":"{range_begin:/registry/jobs/openstack/neutron-ks-endpoints; range_end:; response_count:0; response_revision:16605; }","duration":"549.031014ms","start":"2026-08-19T09:41:21.672055Z","end":"2026-08-19T09:41:22.221086Z","steps":["trace[2036593902] 'range keys from in-memory index tree'  (duration: 547.342987ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:41:22.221166Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T09:41:21.67203Z","time spent":"549.119335ms","remote":"127.0.0.1:32962","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":0,"response size":29,"request content":"key:\"/registry/jobs/openstack/neutron-ks-endpoints\" "}
{"level":"warn","ts":"2026-08-19T09:41:22.219725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"333.021399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/neutron-db-sync\" ","response":"range_response_count:1 size:5311"}
{"level":"info","ts":"2026-08-19T09:41:22.221303Z","caller":"traceutil/trace.go:171","msg":"trace[1659106919] range","detail":"{range_begin:/registry/jobs/openstack/neutron-db-sync; range_end:; response_count:1; response_revision:16605; }","duration":"334.617403ms","start":"2026-08-19T09:41:21.886668Z","end":"2026-08-19T09:41:22.221286Z","steps":["trace[1659106919] 'range keys from in-memory index tree'  (duration: 332.773113ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:41:22.221348Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T09:41:21.88666Z","time spent":"334.675595ms","remote":"127.0.0.1:32962","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":5334,"request content":"key:\"/registry/jobs/openstack/neutron-db-sync\" "}
{"level":"warn","ts":"2026-08-19T09:41:23.711033Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13928402303010701003,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-08-19T09:41:25.063944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.873753595s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/neutron-server\" ","response":"range_response_count:1 size:701"}
{"level":"info","ts":"2026-08-19T09:41:25.064016Z","caller":"traceutil/trace.go:171","msg":"trace[997440368] range","detail":"{range_begin:/registry/services/endpoints/openstack/neutron-server; range_end:; response_count:1; response_revision:16612; }","duration":"1.873867318s","start":"2026-08-19T09:41:23.190129Z","end":"2026-08-19T09:41:25.063997Z","steps":["trace[997440368] 'range keys from in-memory index tree'  (duration: 784.478195ms)","trace[997440368] 'range keys from bolt db'  (duration: 1.089176237s)"],"step_count":2}
{"level":"warn","ts":"2026-08-19T09:41:25.064047Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T09:41:23.190106Z","time spent":"1.87393375s","remote":"127.0.0.1:32898","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":724,"request content":"key:\"/registry/services/endpoints/openstack/neutron-server\" "}
{"level":"warn","ts":"2026-08-19T09:41:25.070538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.879220903s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/neutron-rabbit-init\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-19T09:41:25.070609Z","caller":"traceutil/trace.go:171","msg":"trace[344157512] range","detail":"{range_begin:/registry/jobs/openstack/neutron-rabbit-init; range_end:; response_count:0; response_revision:16612; }","duration":"1.879325976s","start":"2026-08-19T09:41:23.191267Z","end":"2026-08-19T09:41:25.070593Z","steps":["trace[344157512] 'range keys from in-memory index tree'  (duration: 783.594001ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:41:25.070671Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T09:41:23.191256Z","time spent":"1.879400829s","remote":"127.0.0.1:32962","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":0,"response size":29,"request content":"key:\"/registry/jobs/openstack/neutron-rabbit-init\" "}
{"level":"warn","ts":"2026-08-19T09:41:25.072135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.109485499s","expected-duration":"100ms","prefix":"","request":"header:<ID:13928402303010701004 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:16604 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:477 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >>","response":"size:18"}
{"level":"info","ts":"2026-08-19T09:41:25.072222Z","caller":"traceutil/trace.go:171","msg":"trace[1086798109] linearizableReadLoop","detail":"{readStateIndex:17183; appliedIndex:17182; }","duration":"1.86143252s","start":"2026-08-19T09:41:23.210776Z","end":"2026-08-19T09:41:25.072209Z","steps":["trace[1086798109] 'read index received'  (duration: 751.731787ms)","trace[1086798109] 'applied index is now lower than readState.Index'  (duration: 1.109699653s)"],"step_count":2}
{"level":"info","ts":"2026-08-19T09:41:25.072867Z","caller":"traceutil/trace.go:171","msg":"trace[1329677697] transaction","detail":"{read_only:false; response_revision:16613; number_of_response:1; }","duration":"1.871535834s","start":"2026-08-19T09:41:23.201319Z","end":"2026-08-19T09:41:25.072855Z","steps":["trace[1329677697] 'process raft request'  (duration: 761.255204ms)","trace[1329677697] 'compare'  (duration: 1.109352694s)"],"step_count":2}
{"level":"warn","ts":"2026-08-19T09:41:25.072925Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T09:41:23.201299Z","time spent":"1.871598306s","remote":"127.0.0.1:33000","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:16604 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:477 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-08-19T09:41:25.073125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.862359875s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/neutron-server\" ","response":"range_response_count:1 size:701"}
{"level":"info","ts":"2026-08-19T09:41:25.073145Z","caller":"traceutil/trace.go:171","msg":"trace[1923388610] range","detail":"{range_begin:/registry/services/endpoints/openstack/neutron-server; range_end:; response_count:1; response_revision:16613; }","duration":"1.862423518s","start":"2026-08-19T09:41:23.210716Z","end":"2026-08-19T09:41:25.073139Z","steps":["trace[1923388610] 'agreement among raft nodes before linearized reading'  (duration: 1.862333835s)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:41:25.073163Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T09:41:23.210695Z","time spent":"1.862463878s","remote":"127.0.0.1:32898","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":724,"request content":"key:\"/registry/services/endpoints/openstack/neutron-server\" "}
{"level":"warn","ts":"2026-08-19T09:41:25.073328Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.801083272s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/neutron-server\" ","response":"range_response_count:1 size:701"}
{"level":"info","ts":"2026-08-19T09:41:25.073349Z","caller":"traceutil/trace.go:171","msg":"trace[309644183] range","detail":"{range_begin:/registry/services/endpoints/openstack/neutron-server; range_end:; response_count:1; response_revision:16613; }","duration":"1.801141984s","start":"2026-08-19T09:41:23.2722Z","end":"2026-08-19T09:41:25.073342Z","steps":["trace[309644183] 'agreement among raft nodes before linearized reading'  (duration: 1.801059361s)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:41:25.073364Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T09:41:23.272179Z","time spent":"1.801181825s","remote":"127.0.0.1:32898","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":724,"request content":"key:\"/registry/services/endpoints/openstack/neutron-server\" "}
{"level":"warn","ts":"2026-08-19T09:41:25.073368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.800745953s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/neutron-server\" ","response":"range_response_count:1 size:701"}
{"level":"warn","ts":"2026-08-19T09:41:25.073363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.801439361s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/neutron-rabbit-init\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-19T09:41:25.073398Z","caller":"traceutil/trace.go:171","msg":"trace[1893963831] range","detail":"{range_begin:/registry/services/endpoints/openstack/neutron-server; range_end:; response_count:1; response_revision:16613; }","duration":"1.800795173s","start":"2026-08-19T09:41:23.272594Z","end":"2026-08-19T09:41:25.07339Z","steps":["trace[1893963831] 'agreement among raft nodes before linearized reading'  (duration: 1.800715761s)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:41:25.073407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.801871673s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/neutron-rabbit-init\" ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-08-19T09:41:25.073422Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T09:41:23.272585Z","time spent":"1.800832375s","remote":"127.0.0.1:32898","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":724,"request content":"key:\"/registry/services/endpoints/openstack/neutron-server\" "}
{"level":"info","ts":"2026-08-19T09:41:25.073427Z","caller":"traceutil/trace.go:171","msg":"trace[883916321] range","detail":"{range_begin:/registry/jobs/openstack/neutron-rabbit-init; range_end:; response_count:0; response_revision:16613; }","duration":"1.801940435s","start":"2026-08-19T09:41:23.27148Z","end":"2026-08-19T09:41:25.073421Z","steps":["trace[883916321] 'agreement among raft nodes before linearized reading'  (duration: 1.801909874s)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:41:25.073425Z","caller":"traceutil/trace.go:171","msg":"trace[1501637977] range","detail":"{range_begin:/registry/jobs/openstack/neutron-rabbit-init; range_end:; response_count:0; response_revision:16613; }","duration":"1.801533394s","start":"2026-08-19T09:41:23.271876Z","end":"2026-08-19T09:41:25.073409Z","steps":["trace[1501637977] 'agreement among raft nodes before linearized reading'  (duration: 1.801418201s)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:41:25.073445Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T09:41:23.271451Z","time spent":"1.801989496s","remote":"127.0.0.1:32962","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":0,"response size":29,"request content":"key:\"/registry/jobs/openstack/neutron-rabbit-init\" "}
{"level":"warn","ts":"2026-08-19T09:41:25.073457Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T09:41:23.271865Z","time spent":"1.801585085s","remote":"127.0.0.1:32962","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":0,"response size":29,"request content":"key:\"/registry/jobs/openstack/neutron-rabbit-init\" "}
{"level":"warn","ts":"2026-08-19T09:41:25.073376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.804057113s","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-08-19T09:41:25.073494Z","caller":"traceutil/trace.go:171","msg":"trace[563426664] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:16613; }","duration":"1.804222857s","start":"2026-08-19T09:41:23.269265Z","end":"2026-08-19T09:41:25.073488Z","steps":["trace[563426664] 'agreement among raft nodes before linearized reading'  (duration: 1.804067292s)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:41:25.073513Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T09:41:23.26924Z","time spent":"1.804268498s","remote":"127.0.0.1:33000","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-08-19T09:41:25.073468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.614011354s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-19T09:41:25.073605Z","caller":"traceutil/trace.go:171","msg":"trace[1841075686] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:16613; }","duration":"1.614207239s","start":"2026-08-19T09:41:23.459355Z","end":"2026-08-19T09:41:25.073562Z","steps":["trace[1841075686] 'agreement among raft nodes before linearized reading'  (duration: 1.613945892s)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:41:25.073671Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T09:41:23.459331Z","time spent":"1.614326661s","remote":"127.0.0.1:60980","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-08-19T09:43:38.404287Z","caller":"traceutil/trace.go:171","msg":"trace[854471173] linearizableReadLoop","detail":"{readStateIndex:18131; appliedIndex:18130; }","duration":"119.467701ms","start":"2026-08-19T09:43:38.2848Z","end":"2026-08-19T09:43:38.404268Z","steps":["trace[854471173] 'read index received'  (duration: 119.283056ms)","trace[854471173] 'applied index is now lower than readState.Index'  (duration: 184.105µs)"],"step_count":2}
{"level":"info","ts":"2026-08-19T09:43:38.404661Z","caller":"traceutil/trace.go:171","msg":"trace[2096177534] transaction","detail":"{read_only:false; response_revision:17529; number_of_response:1; }","duration":"134.790517ms","start":"2026-08-19T09:43:38.269862Z","end":"2026-08-19T09:43:38.404653Z","steps":["trace[2096177534] 'process raft request'  (duration: 134.291044ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:43:38.404612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.770778ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/orders/\" range_end:\"/registry/acme.cert-manager.io/orders0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-19T09:43:38.404725Z","caller":"traceutil/trace.go:171","msg":"trace[985423746] range","detail":"{range_begin:/registry/acme.cert-manager.io/orders/; range_end:/registry/acme.cert-manager.io/orders0; response_count:0; response_revision:17529; }","duration":"119.944004ms","start":"2026-08-19T09:43:38.284758Z","end":"2026-08-19T09:43:38.404702Z","steps":["trace[985423746] 'agreement among raft nodes before linearized reading'  (duration: 119.736848ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:43:43.730367Z","caller":"traceutil/trace.go:171","msg":"trace[1569599199] transaction","detail":"{read_only:false; response_revision:17558; number_of_response:1; }","duration":"117.999191ms","start":"2026-08-19T09:43:43.612347Z","end":"2026-08-19T09:43:43.730346Z","steps":["trace[1569599199] 'process raft request'  (duration: 117.683563ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:43:44.006869Z","caller":"traceutil/trace.go:171","msg":"trace[129446455] transaction","detail":"{read_only:false; response_revision:17563; number_of_response:1; }","duration":"124.678822ms","start":"2026-08-19T09:43:43.882156Z","end":"2026-08-19T09:43:44.006835Z","steps":["trace[129446455] 'process raft request'  (duration: 124.382484ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:43:44.007171Z","caller":"traceutil/trace.go:171","msg":"trace[1668024520] transaction","detail":"{read_only:false; response_revision:17564; number_of_response:1; }","duration":"123.979133ms","start":"2026-08-19T09:43:43.883152Z","end":"2026-08-19T09:43:44.007131Z","steps":["trace[1668024520] 'process raft request'  (duration: 123.590172ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:43:44.281975Z","caller":"traceutil/trace.go:171","msg":"trace[1431295190] linearizableReadLoop","detail":"{readStateIndex:18168; appliedIndex:18167; }","duration":"270.677905ms","start":"2026-08-19T09:43:44.011267Z","end":"2026-08-19T09:43:44.281945Z","steps":["trace[1431295190] 'read index received'  (duration: 246.696342ms)","trace[1431295190] 'applied index is now lower than readState.Index'  (duration: 23.980073ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T09:43:44.282018Z","caller":"traceutil/trace.go:171","msg":"trace[128400036] transaction","detail":"{read_only:false; response_revision:17565; number_of_response:1; }","duration":"304.510245ms","start":"2026-08-19T09:43:43.977476Z","end":"2026-08-19T09:43:44.281987Z","steps":["trace[128400036] 'process raft request'  (duration: 280.46899ms)","trace[128400036] 'compare'  (duration: 23.739376ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-19T09:43:44.28217Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T09:43:43.977451Z","time spent":"304.643718ms","remote":"127.0.0.1:33000","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:17551 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-08-19T09:43:44.28264Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.357414ms","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-08-19T09:43:44.282693Z","caller":"traceutil/trace.go:171","msg":"trace[314058581] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:17565; }","duration":"271.427086ms","start":"2026-08-19T09:43:44.011254Z","end":"2026-08-19T09:43:44.282681Z","steps":["trace[314058581] 'agreement among raft nodes before linearized reading'  (duration: 270.829089ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:43:44.688188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.855939ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13928402303010704903 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<key:\"compact_rev_key\" version:6 > success:<request_put:<key:\"compact_rev_key\" value_size:5 >> failure:<request_range:<key:\"compact_rev_key\" > >>","response":"size:18"}
{"level":"info","ts":"2026-08-19T09:43:44.688279Z","caller":"traceutil/trace.go:171","msg":"trace[1521092788] linearizableReadLoop","detail":"{readStateIndex:18169; appliedIndex:18168; }","duration":"406.202152ms","start":"2026-08-19T09:43:44.282055Z","end":"2026-08-19T09:43:44.688257Z","steps":["trace[1521092788] 'read index received'  (duration: 203.131416ms)","trace[1521092788] 'applied index is now lower than readState.Index'  (duration: 203.069046ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T09:43:44.688341Z","caller":"traceutil/trace.go:171","msg":"trace[540123403] transaction","detail":"{read_only:false; response_revision:17566; number_of_response:1; }","duration":"646.046239ms","start":"2026-08-19T09:43:44.042247Z","end":"2026-08-19T09:43:44.688293Z","steps":["trace[540123403] 'process raft request'  (duration: 443.011525ms)","trace[540123403] 'compare'  (duration: 202.638863ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-19T09:43:44.6885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"404.427814ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:18621"}
{"level":"info","ts":"2026-08-19T09:43:44.688531Z","caller":"traceutil/trace.go:171","msg":"trace[758008348] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:17566; }","duration":"404.487566ms","start":"2026-08-19T09:43:44.284035Z","end":"2026-08-19T09:43:44.688523Z","steps":["trace[758008348] 'agreement among raft nodes before linearized reading'  (duration: 404.381993ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:43:44.68854Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T09:43:44.042228Z","time spent":"646.212893ms","remote":"127.0.0.1:60986","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":26,"response count":0,"response size":41,"request content":"compare:<key:\"compact_rev_key\" version:6 > success:<request_put:<key:\"compact_rev_key\" value_size:5 >> failure:<request_range:<key:\"compact_rev_key\" > >"}
{"level":"warn","ts":"2026-08-19T09:43:44.688394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"574.677707ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-08-19T09:43:44.688835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.951777ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-19T09:43:44.688859Z","caller":"traceutil/trace.go:171","msg":"trace[1869466227] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:17566; }","duration":"229.970287ms","start":"2026-08-19T09:43:44.45888Z","end":"2026-08-19T09:43:44.68885Z","steps":["trace[1869466227] 'agreement among raft nodes before linearized reading'  (duration: 229.942096ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:43:44.688858Z","caller":"traceutil/trace.go:171","msg":"trace[1191190915] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:17566; }","duration":"575.132719ms","start":"2026-08-19T09:43:44.113706Z","end":"2026-08-19T09:43:44.688839Z","steps":["trace[1191190915] 'agreement among raft nodes before linearized reading'  (duration: 574.630255ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:43:44.688926Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T09:43:44.11363Z","time spent":"575.275363ms","remote":"127.0.0.1:32872","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":29,"request content":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true "}
{"level":"warn","ts":"2026-08-19T09:43:44.688562Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T09:43:44.284019Z","time spent":"404.537157ms","remote":"127.0.0.1:32914","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":18644,"request content":"key:\"/registry/minions/instance\" "}
{"level":"warn","ts":"2026-08-19T09:43:44.688808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.803461ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/federations/\" range_end:\"/registry/rabbitmq.com/federations0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-19T09:43:44.689192Z","caller":"traceutil/trace.go:171","msg":"trace[1819436394] range","detail":"{range_begin:/registry/rabbitmq.com/federations/; range_end:/registry/rabbitmq.com/federations0; response_count:0; response_revision:17566; }","duration":"177.201911ms","start":"2026-08-19T09:43:44.511957Z","end":"2026-08-19T09:43:44.689159Z","steps":["trace[1819436394] 'agreement among raft nodes before linearized reading'  (duration: 176.829732ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:43:44.770895Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15295}
{"level":"info","ts":"2026-08-19T09:43:44.909975Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15295,"took":"136.201595ms","hash":2198033436,"current-db-size-bytes":56451072,"current-db-size":"56 MB","current-db-size-in-use-bytes":32198656,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-08-19T09:43:44.910018Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2198033436,"revision":15295,"compact-revision":12829}
{"level":"info","ts":"2026-08-19T09:47:16.515132Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"e44ae1545340c14b","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-08-19T09:47:16.521075Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002}
{"level":"info","ts":"2026-08-19T09:47:16.521283Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002}
{"level":"info","ts":"2026-08-19T09:48:44.778399Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17566}
{"level":"info","ts":"2026-08-19T09:48:44.880175Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17566,"took":"97.816641ms","hash":1626872042,"current-db-size-bytes":56451072,"current-db-size":"56 MB","current-db-size-in-use-bytes":34050048,"current-db-size-in-use":"34 MB"}
{"level":"info","ts":"2026-08-19T09:48:44.880247Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1626872042,"revision":17566,"compact-revision":15295}
{"level":"warn","ts":"2026-08-19T09:48:55.819347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.202012ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13928402303010712160 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:20048 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:18"}
{"level":"info","ts":"2026-08-19T09:48:55.819466Z","caller":"traceutil/trace.go:171","msg":"trace[920232071] linearizableReadLoop","detail":"{readStateIndex:20741; appliedIndex:20740; }","duration":"211.809133ms","start":"2026-08-19T09:48:55.607641Z","end":"2026-08-19T09:48:55.81945Z","steps":["trace[920232071] 'read index received'  (duration: 45.311643ms)","trace[920232071] 'applied index is now lower than readState.Index'  (duration: 166.49629ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-19T09:48:55.819666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.186319ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-08-19T09:48:55.819755Z","caller":"traceutil/trace.go:171","msg":"trace[1020666015] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:20057; }","duration":"210.294282ms","start":"2026-08-19T09:48:55.609441Z","end":"2026-08-19T09:48:55.819736Z","steps":["trace[1020666015] 'agreement among raft nodes before linearized reading'  (duration: 210.111487ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:48:55.819666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.010069ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"}
{"level":"info","ts":"2026-08-19T09:48:55.819857Z","caller":"traceutil/trace.go:171","msg":"trace[33232615] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:20057; }","duration":"212.204724ms","start":"2026-08-19T09:48:55.607632Z","end":"2026-08-19T09:48:55.819837Z","steps":["trace[33232615] 'agreement among raft nodes before linearized reading'  (duration: 211.898476ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:48:55.819629Z","caller":"traceutil/trace.go:171","msg":"trace[818703343] transaction","detail":"{read_only:false; response_revision:20057; number_of_response:1; }","duration":"322.422333ms","start":"2026-08-19T09:48:55.49712Z","end":"2026-08-19T09:48:55.819542Z","steps":["trace[818703343] 'process raft request'  (duration: 155.942143ms)","trace[818703343] 'compare'  (duration: 165.734469ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-19T09:48:55.819997Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T09:48:55.497102Z","time spent":"322.858444ms","remote":"127.0.0.1:33000","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:20048 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-08-19T09:48:55.923867Z","caller":"traceutil/trace.go:171","msg":"trace[636623438] transaction","detail":"{read_only:false; response_revision:20059; number_of_response:1; }","duration":"100.215226ms","start":"2026-08-19T09:48:55.823618Z","end":"2026-08-19T09:48:55.923833Z","steps":["trace[636623438] 'process raft request'  (duration: 99.731043ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:48:55.924146Z","caller":"traceutil/trace.go:171","msg":"trace[754641515] transaction","detail":"{read_only:false; response_revision:20060; number_of_response:1; }","duration":"100.154035ms","start":"2026-08-19T09:48:55.82396Z","end":"2026-08-19T09:48:55.924114Z","steps":["trace[754641515] 'process raft request'  (duration: 99.812446ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:49:11.822379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"362.260627ms","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-08-19T09:49:11.822502Z","caller":"traceutil/trace.go:171","msg":"trace[83658291] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:20138; }","duration":"362.426781ms","start":"2026-08-19T09:49:11.46005Z","end":"2026-08-19T09:49:11.822477Z","steps":["trace[83658291] 'range keys from in-memory index tree'  (duration: 362.160334ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:49:11.822553Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T09:49:11.460034Z","time spent":"362.508193ms","remote":"127.0.0.1:33184","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":"warn","ts":"2026-08-19T09:49:11.822611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.102046ms","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-08-19T09:49:11.822673Z","caller":"traceutil/trace.go:171","msg":"trace[1346074983] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:20138; }","duration":"246.203729ms","start":"2026-08-19T09:49:11.576455Z","end":"2026-08-19T09:49:11.822659Z","steps":["trace[1346074983] 'range keys from in-memory index tree'  (duration: 245.965171ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:49:12.192362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.919611ms","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-08-19T09:49:12.192468Z","caller":"traceutil/trace.go:171","msg":"trace[251907129] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:20139; }","duration":"174.036825ms","start":"2026-08-19T09:49:12.018411Z","end":"2026-08-19T09:49:12.192448Z","steps":["trace[251907129] 'range keys from in-memory index tree'  (duration: 173.903031ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:49:12.192747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.466247ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13928402303010712382 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:20130 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:18"}
{"level":"info","ts":"2026-08-19T09:49:12.19282Z","caller":"traceutil/trace.go:171","msg":"trace[838194607] linearizableReadLoop","detail":"{readStateIndex:20827; appliedIndex:20826; }","duration":"220.553042ms","start":"2026-08-19T09:49:11.972256Z","end":"2026-08-19T09:49:12.192809Z","steps":["trace[838194607] 'read index received'  (duration: 70.849648ms)","trace[838194607] 'applied index is now lower than readState.Index'  (duration: 149.702264ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T09:49:12.192914Z","caller":"traceutil/trace.go:171","msg":"trace[85161171] transaction","detail":"{read_only:false; response_revision:20140; number_of_response:1; }","duration":"292.810677ms","start":"2026-08-19T09:49:11.900093Z","end":"2026-08-19T09:49:12.192904Z","steps":["trace[85161171] 'process raft request'  (duration: 143.128314ms)","trace[85161171] 'compare'  (duration: 149.21349ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-19T09:49:12.193032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.836217ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"}
{"level":"info","ts":"2026-08-19T09:49:12.193056Z","caller":"traceutil/trace.go:171","msg":"trace[1647126706] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:20140; }","duration":"185.899068ms","start":"2026-08-19T09:49:12.007149Z","end":"2026-08-19T09:49:12.193049Z","steps":["trace[1647126706] 'agreement among raft nodes before linearized reading'  (duration: 185.812715ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:49:12.1932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.504148ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"}
{"level":"info","ts":"2026-08-19T09:49:12.193234Z","caller":"traceutil/trace.go:171","msg":"trace[1056327925] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:20140; }","duration":"181.58408ms","start":"2026-08-19T09:49:12.01164Z","end":"2026-08-19T09:49:12.193224Z","steps":["trace[1056327925] 'agreement among raft nodes before linearized reading'  (duration: 181.481837ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:49:12.193269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.718904ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:558"}
{"level":"info","ts":"2026-08-19T09:49:12.193296Z","caller":"traceutil/trace.go:171","msg":"trace[140148430] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:20140; }","duration":"181.787026ms","start":"2026-08-19T09:49:12.0115Z","end":"2026-08-19T09:49:12.193287Z","steps":["trace[140148430] 'agreement among raft nodes before linearized reading'  (duration: 181.706755ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:49:12.193363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.085286ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-08-19T09:49:12.193461Z","caller":"traceutil/trace.go:171","msg":"trace[1080165968] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:20140; }","duration":"221.220279ms","start":"2026-08-19T09:49:11.972211Z","end":"2026-08-19T09:49:12.193431Z","steps":["trace[1080165968] 'agreement among raft nodes before linearized reading'  (duration: 220.977661ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:49:12.433995Z","caller":"traceutil/trace.go:171","msg":"trace[1960103183] transaction","detail":"{read_only:false; response_revision:20141; number_of_response:1; }","duration":"237.520952ms","start":"2026-08-19T09:49:12.196448Z","end":"2026-08-19T09:49:12.433968Z","steps":["trace[1960103183] 'process raft request'  (duration: 192.64313ms)","trace[1960103183] 'compare'  (duration: 44.692497ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T09:49:12.462919Z","caller":"traceutil/trace.go:171","msg":"trace[2146113996] transaction","detail":"{read_only:false; response_revision:20142; number_of_response:1; }","duration":"266.392959ms","start":"2026-08-19T09:49:12.196505Z","end":"2026-08-19T09:49:12.462898Z","steps":["trace[2146113996] 'process raft request'  (duration: 266.206653ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:49:12.463155Z","caller":"traceutil/trace.go:171","msg":"trace[1132961948] transaction","detail":"{read_only:false; response_revision:20143; number_of_response:1; }","duration":"266.556153ms","start":"2026-08-19T09:49:12.196577Z","end":"2026-08-19T09:49:12.463133Z","steps":["trace[1132961948] 'process raft request'  (duration: 266.277825ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:49:12.463325Z","caller":"traceutil/trace.go:171","msg":"trace[1603512481] transaction","detail":"{read_only:false; response_revision:20144; number_of_response:1; }","duration":"266.427579ms","start":"2026-08-19T09:49:12.196884Z","end":"2026-08-19T09:49:12.463312Z","steps":["trace[1603512481] 'process raft request'  (duration: 266.196693ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:49:12.463348Z","caller":"traceutil/trace.go:171","msg":"trace[1545051434] linearizableReadLoop","detail":"{readStateIndex:20831; appliedIndex:20827; }","duration":"205.980915ms","start":"2026-08-19T09:49:12.257337Z","end":"2026-08-19T09:49:12.463318Z","steps":["trace[1545051434] 'read index received'  (duration: 131.769036ms)","trace[1545051434] 'applied index is now lower than readState.Index'  (duration: 74.210349ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-19T09:49:12.463468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.122958ms","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-08-19T09:49:12.463513Z","caller":"traceutil/trace.go:171","msg":"trace[2048710687] range","detail":"{range_begin:/registry/rabbitmq.com/operatorpolicies/; range_end:/registry/rabbitmq.com/operatorpolicies0; response_count:0; response_revision:20144; }","duration":"206.21774ms","start":"2026-08-19T09:49:12.25728Z","end":"2026-08-19T09:49:12.463498Z","steps":["trace[2048710687] 'agreement among raft nodes before linearized reading'  (duration: 206.131229ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:49:13.021984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.883813ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13928402303010712393 > lease_revoke:<id:414ba01947afaa79>","response":"size:29"}
{"level":"info","ts":"2026-08-19T09:49:13.022265Z","caller":"traceutil/trace.go:171","msg":"trace[1484699247] linearizableReadLoop","detail":"{readStateIndex:20832; appliedIndex:20831; }","duration":"281.838489ms","start":"2026-08-19T09:49:12.740389Z","end":"2026-08-19T09:49:13.022227Z","steps":["trace[1484699247] 'read index received'  (duration: 90.37417ms)","trace[1484699247] 'applied index is now lower than readState.Index'  (duration: 191.459419ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-19T09:49:13.022552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.153247ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:533"}
{"level":"info","ts":"2026-08-19T09:49:13.022607Z","caller":"traceutil/trace.go:171","msg":"trace[2038883532] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:20145; }","duration":"282.27057ms","start":"2026-08-19T09:49:12.740321Z","end":"2026-08-19T09:49:13.022591Z","steps":["trace[2038883532] 'agreement among raft nodes before linearized reading'  (duration: 282.026114ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:49:13.352796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.303285ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13928402303010712395 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:20135 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >>","response":"size:18"}
{"level":"info","ts":"2026-08-19T09:49:13.35309Z","caller":"traceutil/trace.go:171","msg":"trace[243462361] transaction","detail":"{read_only:false; response_revision:20146; number_of_response:1; }","duration":"414.058295ms","start":"2026-08-19T09:49:12.938995Z","end":"2026-08-19T09:49:13.353053Z","steps":["trace[243462361] 'process raft request'  (duration: 222.394011ms)","trace[243462361] 'compare'  (duration: 191.113489ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T09:49:13.35312Z","caller":"traceutil/trace.go:171","msg":"trace[2119857144] linearizableReadLoop","detail":"{readStateIndex:20836; appliedIndex:20833; }","duration":"267.481588ms","start":"2026-08-19T09:49:13.085615Z","end":"2026-08-19T09:49:13.353097Z","steps":["trace[2119857144] 'read index received'  (duration: 75.788862ms)","trace[2119857144] 'applied index is now lower than readState.Index'  (duration: 191.691446ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T09:49:13.353256Z","caller":"traceutil/trace.go:171","msg":"trace[1953696847] transaction","detail":"{read_only:false; response_revision:20147; number_of_response:1; }","duration":"326.207536ms","start":"2026-08-19T09:49:13.027032Z","end":"2026-08-19T09:49:13.35324Z","steps":["trace[1953696847] 'process raft request'  (duration: 325.912927ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:49:13.353268Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T09:49:12.938963Z","time spent":"414.20294ms","remote":"127.0.0.1:33000","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:20135 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"warn","ts":"2026-08-19T09:49:13.353359Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T09:49:13.027012Z","time spent":"326.294439ms","remote":"127.0.0.1:33000","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:20069 > 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-08-19T09:49:13.353443Z","caller":"traceutil/trace.go:171","msg":"trace[679032082] transaction","detail":"{read_only:false; response_revision:20148; number_of_response:1; }","duration":"294.871073ms","start":"2026-08-19T09:49:13.058533Z","end":"2026-08-19T09:49:13.353404Z","steps":["trace[679032082] 'process raft request'  (duration: 294.498283ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:49:13.353588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.90722ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclients/\" range_end:\"/registry/ceph.rook.io/cephclients0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-19T09:49:13.353681Z","caller":"traceutil/trace.go:171","msg":"trace[945257200] range","detail":"{range_begin:/registry/ceph.rook.io/cephclients/; range_end:/registry/ceph.rook.io/cephclients0; response_count:0; response_revision:20148; }","duration":"268.090084ms","start":"2026-08-19T09:49:13.085568Z","end":"2026-08-19T09:49:13.353659Z","steps":["trace[945257200] 'agreement among raft nodes before linearized reading'  (duration: 267.743745ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:52:55.774339Z","caller":"traceutil/trace.go:171","msg":"trace[505812297] linearizableReadLoop","detail":"{readStateIndex:23283; appliedIndex:23282; }","duration":"315.252428ms","start":"2026-08-19T09:52:55.459059Z","end":"2026-08-19T09:52:55.774312Z","steps":["trace[505812297] 'read index received'  (duration: 252.539131ms)","trace[505812297] 'applied index is now lower than readState.Index'  (duration: 62.712017ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T09:52:55.774382Z","caller":"traceutil/trace.go:171","msg":"trace[669929392] transaction","detail":"{read_only:false; response_revision:22525; number_of_response:1; }","duration":"422.664581ms","start":"2026-08-19T09:52:55.351667Z","end":"2026-08-19T09:52:55.774332Z","steps":["trace[669929392] 'process raft request'  (duration: 359.951545ms)","trace[669929392] 'compare'  (duration: 62.476359ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-19T09:52:55.77449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.417472ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-19T09:52:55.774542Z","caller":"traceutil/trace.go:171","msg":"trace[1921842603] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:22525; }","duration":"315.537655ms","start":"2026-08-19T09:52:55.458993Z","end":"2026-08-19T09:52:55.774531Z","steps":["trace[1921842603] 'agreement among raft nodes before linearized reading'  (duration: 315.423652ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:52:55.774543Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T09:52:55.351644Z","time spent":"422.821264ms","remote":"127.0.0.1:33000","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/capi-system/controller-leader-election-capi\" mod_revision:22469 > success:<request_put:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" > >"}
{"level":"warn","ts":"2026-08-19T09:52:55.77457Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T09:52:55.458962Z","time spent":"315.601877ms","remote":"127.0.0.1:60974","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-08-19T09:52:55.776001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.752799ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"}
{"level":"info","ts":"2026-08-19T09:52:55.776051Z","caller":"traceutil/trace.go:171","msg":"trace[1418465885] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:22526; }","duration":"176.837311ms","start":"2026-08-19T09:52:55.599198Z","end":"2026-08-19T09:52:55.776035Z","steps":["trace[1418465885] 'agreement among raft nodes before linearized reading'  (duration: 176.694217ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:52:55.776053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.865282ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-08-19T09:52:55.776093Z","caller":"traceutil/trace.go:171","msg":"trace[1077760426] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:22526; }","duration":"176.948765ms","start":"2026-08-19T09:52:55.599134Z","end":"2026-08-19T09:52:55.776083Z","steps":["trace[1077760426] 'agreement among raft nodes before linearized reading'  (duration: 176.814472ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:52:55.776163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.074236ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/prometheusagents/\" range_end:\"/registry/monitoring.coreos.com/prometheusagents0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-08-19T09:52:55.776265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.239567ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:558"}
{"level":"info","ts":"2026-08-19T09:52:55.776283Z","caller":"traceutil/trace.go:171","msg":"trace[2071164969] transaction","detail":"{read_only:false; response_revision:22526; number_of_response:1; }","duration":"269.74258ms","start":"2026-08-19T09:52:55.506496Z","end":"2026-08-19T09:52:55.776239Z","steps":["trace[2071164969] 'process raft request'  (duration: 269.267476ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:52:55.776274Z","caller":"traceutil/trace.go:171","msg":"trace[160784156] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheusagents/; range_end:/registry/monitoring.coreos.com/prometheusagents0; response_count:0; response_revision:22526; }","duration":"113.255982ms","start":"2026-08-19T09:52:55.662994Z","end":"2026-08-19T09:52:55.77625Z","steps":["trace[160784156] 'agreement among raft nodes before linearized reading'  (duration: 113.044806ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:52:55.776327Z","caller":"traceutil/trace.go:171","msg":"trace[1148391765] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:22526; }","duration":"165.342329ms","start":"2026-08-19T09:52:55.610967Z","end":"2026-08-19T09:52:55.776309Z","steps":["trace[1148391765] 'agreement among raft nodes before linearized reading'  (duration: 165.194755ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:52:55.776216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.968578ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"}
{"level":"info","ts":"2026-08-19T09:52:55.776404Z","caller":"traceutil/trace.go:171","msg":"trace[1855384670] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:22526; }","duration":"172.186686ms","start":"2026-08-19T09:52:55.604205Z","end":"2026-08-19T09:52:55.776392Z","steps":["trace[1855384670] 'agreement among raft nodes before linearized reading'  (duration: 171.957789ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T09:52:55.7764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.687371ms","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-08-19T09:52:55.776454Z","caller":"traceutil/trace.go:171","msg":"trace[368032696] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:22526; }","duration":"293.823754ms","start":"2026-08-19T09:52:55.482612Z","end":"2026-08-19T09:52:55.776436Z","steps":["trace[368032696] 'agreement among raft nodes before linearized reading'  (duration: 293.312621ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T09:53:44.785951Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":20002}
{"level":"info","ts":"2026-08-19T09:53:44.903874Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":20002,"took":"111.432592ms","hash":706345355,"current-db-size-bytes":56451072,"current-db-size":"56 MB","current-db-size-in-use-bytes":42373120,"current-db-size-in-use":"42 MB"}
{"level":"info","ts":"2026-08-19T09:53:44.90401Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":706345355,"revision":20002,"compact-revision":17566}
{"level":"info","ts":"2026-08-19T09:58:44.794791Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":22997}
{"level":"info","ts":"2026-08-19T09:58:44.929018Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":22997,"took":"131.047776ms","hash":3546865325,"current-db-size-bytes":56451072,"current-db-size":"56 MB","current-db-size-in-use-bytes":31051776,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-08-19T09:58:44.929189Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3546865325,"revision":22997,"compact-revision":20002}