{"level":"warn","ts":"2026-08-05T11:03:52.743008Z","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-05T11:03:52.743086Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.248: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.248:2380","--initial-cluster=instance=https://199.204.45.248:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.248:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.248: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-05T11:03:52.743147Z","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-05T11:03:52.743159Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.248:2380"]}
{"level":"info","ts":"2026-08-05T11:03:52.743176Z","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-05T11:03:52.743786Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.248:2379"]}
{"level":"info","ts":"2026-08-05T11:03:52.743869Z","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.248:2380"],"listen-peer-urls":["https://199.204.45.248:2380"],"advertise-client-urls":["https://199.204.45.248:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.248:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.248: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-05T11:03:52.748206Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.077937ms"}
{"level":"info","ts":"2026-08-05T11:03:52.753534Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"39582465ceaa2f67","cluster-id":"87fd8ddedde3be45"}
{"level":"info","ts":"2026-08-05T11:03:52.753603Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 switched to configuration voters=()"}
{"level":"info","ts":"2026-08-05T11:03:52.753622Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became follower at term 0"}
{"level":"info","ts":"2026-08-05T11:03:52.753636Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 39582465ceaa2f67 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-08-05T11:03:52.753643Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became follower at term 1"}
{"level":"info","ts":"2026-08-05T11:03:52.753676Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 switched to configuration voters=(4132092677789986663)"}
{"level":"warn","ts":"2026-08-05T11:03:52.763376Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-08-05T11:03:52.764655Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-08-05T11:03:52.765777Z","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-05T11:03:52.768406Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"39582465ceaa2f67","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-08-05T11:03:52.768895Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"39582465ceaa2f67","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-08-05T11:03:52.76892Z","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-05T11:03:52.769076Z","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-05T11:03:52.76911Z","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-05T11:03:52.769926Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 switched to configuration voters=(4132092677789986663)"}
{"level":"info","ts":"2026-08-05T11:03:52.770952Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"87fd8ddedde3be45","local-member-id":"39582465ceaa2f67","added-peer-id":"39582465ceaa2f67","added-peer-peer-urls":["https://199.204.45.248:2380"]}
{"level":"info","ts":"2026-08-05T11:03:52.775012Z","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-05T11:03:52.775246Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.248:2380"}
{"level":"info","ts":"2026-08-05T11:03:52.775309Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.248:2380"}
{"level":"info","ts":"2026-08-05T11:03:52.775856Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"39582465ceaa2f67","initial-advertise-peer-urls":["https://199.204.45.248:2380"],"listen-peer-urls":["https://199.204.45.248:2380"],"advertise-client-urls":["https://199.204.45.248:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.248:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-08-05T11:03:52.775921Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-08-05T11:03:53.454119Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 is starting a new election at term 1"}
{"level":"info","ts":"2026-08-05T11:03:53.454209Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became pre-candidate at term 1"}
{"level":"info","ts":"2026-08-05T11:03:53.454265Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 received MsgPreVoteResp from 39582465ceaa2f67 at term 1"}
{"level":"info","ts":"2026-08-05T11:03:53.45429Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became candidate at term 2"}
{"level":"info","ts":"2026-08-05T11:03:53.454308Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 received MsgVoteResp from 39582465ceaa2f67 at term 2"}
{"level":"info","ts":"2026-08-05T11:03:53.454326Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became leader at term 2"}
{"level":"info","ts":"2026-08-05T11:03:53.45435Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 39582465ceaa2f67 elected leader 39582465ceaa2f67 at term 2"}
{"level":"info","ts":"2026-08-05T11:03:53.614616Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-08-05T11:03:53.616074Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"39582465ceaa2f67","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.248:2379]}","request-path":"/0/members/39582465ceaa2f67/attributes","cluster-id":"87fd8ddedde3be45","publish-timeout":"7s"}
{"level":"info","ts":"2026-08-05T11:03:53.61613Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-08-05T11:03:53.616216Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-08-05T11:03:53.616413Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-08-05T11:03:53.61653Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-08-05T11:03:53.617907Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"87fd8ddedde3be45","local-member-id":"39582465ceaa2f67","cluster-version":"3.5"}
{"level":"info","ts":"2026-08-05T11:03:53.61806Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-08-05T11:03:53.618115Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-08-05T11:03:53.620096Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-08-05T11:03:53.620863Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.248:2379"}
{"level":"warn","ts":"2026-08-05T11:04:07.92434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.770736ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" ","response":"range_response_count:1 size:6965"}
{"level":"info","ts":"2026-08-05T11:04:07.924474Z","caller":"traceutil/trace.go:171","msg":"trace[1459735325] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-instance; range_end:; response_count:1; response_revision:406; }","duration":"168.968201ms","start":"2026-08-05T11:04:07.755482Z","end":"2026-08-05T11:04:07.92445Z","steps":["trace[1459735325] 'range keys from in-memory index tree'  (duration: 168.679873ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:04:39.583914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.824163ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-08-05T11:04:39.583995Z","caller":"traceutil/trace.go:171","msg":"trace[833535957] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:645; }","duration":"288.951186ms","start":"2026-08-05T11:04:39.295025Z","end":"2026-08-05T11:04:39.583976Z","steps":["trace[833535957] 'range keys from in-memory index tree'  (duration: 288.68935ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:04:39.584122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"372.588877ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"}
{"level":"info","ts":"2026-08-05T11:04:39.584192Z","caller":"traceutil/trace.go:171","msg":"trace[229790746] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:645; }","duration":"372.703951ms","start":"2026-08-05T11:04:39.211471Z","end":"2026-08-05T11:04:39.584175Z","steps":["trace[229790746] 'range keys from in-memory index tree'  (duration: 372.421423ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:04:39.584222Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T11:04:39.21146Z","time spent":"372.756042ms","remote":"127.0.0.1:46226","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-08-05T11:04:39.715523Z","caller":"traceutil/trace.go:171","msg":"trace[1450731515] transaction","detail":"{read_only:false; response_revision:646; number_of_response:1; }","duration":"357.443177ms","start":"2026-08-05T11:04:39.358046Z","end":"2026-08-05T11:04:39.715489Z","steps":["trace[1450731515] 'process raft request'  (duration: 357.145619ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:04:39.715676Z","caller":"traceutil/trace.go:171","msg":"trace[45185639] linearizableReadLoop","detail":"{readStateIndex:667; appliedIndex:666; }","duration":"153.955619ms","start":"2026-08-05T11:04:39.561453Z","end":"2026-08-05T11:04:39.715408Z","steps":["trace[45185639] 'read index received'  (duration: 153.812205ms)","trace[45185639] 'applied index is now lower than readState.Index'  (duration: 142.494µs)"],"step_count":2}
{"level":"warn","ts":"2026-08-05T11:04:39.71574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.256757ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-05T11:04:39.715896Z","caller":"traceutil/trace.go:171","msg":"trace[1177986960] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:646; }","duration":"154.37255ms","start":"2026-08-05T11:04:39.561429Z","end":"2026-08-05T11:04:39.715802Z","steps":["trace[1177986960] 'agreement among raft nodes before linearized reading'  (duration: 154.184495ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:04:39.716099Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T11:04:39.358026Z","time spent":"357.56793ms","remote":"127.0.0.1:46226","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:523 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"info","ts":"2026-08-05T11:04:39.716953Z","caller":"traceutil/trace.go:171","msg":"trace[55159369] transaction","detail":"{read_only:false; response_revision:647; number_of_response:1; }","duration":"129.077191ms","start":"2026-08-05T11:04:39.587862Z","end":"2026-08-05T11:04:39.716939Z","steps":["trace[55159369] 'process raft request'  (duration: 128.936487ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:04:39.717073Z","caller":"traceutil/trace.go:171","msg":"trace[2131353106] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"129.071201ms","start":"2026-08-05T11:04:39.587983Z","end":"2026-08-05T11:04:39.717055Z","steps":["trace[2131353106] 'process raft request'  (duration: 128.918427ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:04:53.91345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.799051ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-08-05T11:04:53.913558Z","caller":"traceutil/trace.go:171","msg":"trace[170594053] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:797; }","duration":"137.940766ms","start":"2026-08-05T11:04:53.775598Z","end":"2026-08-05T11:04:53.913539Z","steps":["trace[170594053] 'range keys from in-memory index tree'  (duration: 137.651428ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:04:53.91366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.750682ms","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-05T11:04:53.913776Z","caller":"traceutil/trace.go:171","msg":"trace[2098296709] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:797; }","duration":"142.925507ms","start":"2026-08-05T11:04:53.770822Z","end":"2026-08-05T11:04:53.913747Z","steps":["trace[2098296709] 'range keys from in-memory index tree'  (duration: 142.497036ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:06:05.214141Z","caller":"traceutil/trace.go:171","msg":"trace[170716996] transaction","detail":"{read_only:false; response_revision:1850; number_of_response:1; }","duration":"288.452989ms","start":"2026-08-05T11:06:04.925624Z","end":"2026-08-05T11:06:05.214077Z","steps":["trace[170716996] 'process raft request'  (duration: 257.660568ms)","trace[170716996] 'compare'  (duration: 30.210446ms)"],"step_count":2}
{"level":"info","ts":"2026-08-05T11:06:05.27447Z","caller":"traceutil/trace.go:171","msg":"trace[1186362399] transaction","detail":"{read_only:false; response_revision:1851; number_of_response:1; }","duration":"118.087321ms","start":"2026-08-05T11:06:05.156362Z","end":"2026-08-05T11:06:05.274449Z","steps":["trace[1186362399] 'process raft request'  (duration: 117.883245ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:06:54.629634Z","caller":"traceutil/trace.go:171","msg":"trace[750672009] transaction","detail":"{read_only:false; response_revision:2176; number_of_response:1; }","duration":"103.349997ms","start":"2026-08-05T11:06:54.526244Z","end":"2026-08-05T11:06:54.629594Z","steps":["trace[750672009] 'process raft request'  (duration: 103.303526ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:06:54.629713Z","caller":"traceutil/trace.go:171","msg":"trace[726003769] transaction","detail":"{read_only:false; response_revision:2175; number_of_response:1; }","duration":"103.50406ms","start":"2026-08-05T11:06:54.526175Z","end":"2026-08-05T11:06:54.629679Z","steps":["trace[726003769] 'process raft request'  (duration: 27.983852ms)","trace[726003769] 'compare'  (duration: 75.20384ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-05T11:06:55.646606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.993853ms","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-05T11:06:55.646684Z","caller":"traceutil/trace.go:171","msg":"trace[1874932882] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2180; }","duration":"133.127537ms","start":"2026-08-05T11:06:55.513537Z","end":"2026-08-05T11:06:55.646665Z","steps":["trace[1874932882] 'range keys from in-memory index tree'  (duration: 132.833669ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:07:01.100544Z","caller":"traceutil/trace.go:171","msg":"trace[1075224638] transaction","detail":"{read_only:false; response_revision:2210; number_of_response:1; }","duration":"164.045996ms","start":"2026-08-05T11:07:00.936474Z","end":"2026-08-05T11:07:01.10052Z","steps":["trace[1075224638] 'process raft request'  (duration: 163.870922ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:07:49.769652Z","caller":"traceutil/trace.go:171","msg":"trace[893838942] transaction","detail":"{read_only:false; response_revision:2645; number_of_response:1; }","duration":"144.813247ms","start":"2026-08-05T11:07:49.624812Z","end":"2026-08-05T11:07:49.769625Z","steps":["trace[893838942] 'process raft request'  (duration: 144.656513ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:07:49.79738Z","caller":"traceutil/trace.go:171","msg":"trace[1716549280] transaction","detail":"{read_only:false; response_revision:2646; number_of_response:1; }","duration":"166.550942ms","start":"2026-08-05T11:07:49.630766Z","end":"2026-08-05T11:07:49.797317Z","steps":["trace[1716549280] 'process raft request'  (duration: 165.485524ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:08:26.935952Z","caller":"traceutil/trace.go:171","msg":"trace[1947135808] transaction","detail":"{read_only:false; response_revision:2867; number_of_response:1; }","duration":"121.44123ms","start":"2026-08-05T11:08:26.814487Z","end":"2026-08-05T11:08:26.935928Z","steps":["trace[1947135808] 'process raft request'  (duration: 121.285376ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:12:08.735568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.062082ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-08-05T11:12:08.735639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.49186ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-08-05T11:12:08.735682Z","caller":"traceutil/trace.go:171","msg":"trace[1912145891] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4856; }","duration":"176.221597ms","start":"2026-08-05T11:12:08.559433Z","end":"2026-08-05T11:12:08.735655Z","steps":["trace[1912145891] 'range keys from in-memory index tree'  (duration: 175.97012ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:12:08.735728Z","caller":"traceutil/trace.go:171","msg":"trace[525974411] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/; range_end:/registry/apiregistration.k8s.io/apiservices0; response_count:0; response_revision:4856; }","duration":"155.649404ms","start":"2026-08-05T11:12:08.580056Z","end":"2026-08-05T11:12:08.735705Z","steps":["trace[525974411] 'count revisions from in-memory index tree'  (duration: 155.313885ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:12:08.742855Z","caller":"traceutil/trace.go:171","msg":"trace[1761184379] transaction","detail":"{read_only:false; response_revision:4857; number_of_response:1; }","duration":"157.413451ms","start":"2026-08-05T11:12:08.585428Z","end":"2026-08-05T11:12:08.742841Z","steps":["trace[1761184379] 'process raft request'  (duration: 157.232216ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:12:08.750081Z","caller":"traceutil/trace.go:171","msg":"trace[1975693890] transaction","detail":"{read_only:false; response_revision:4858; number_of_response:1; }","duration":"118.080284ms","start":"2026-08-05T11:12:08.631986Z","end":"2026-08-05T11:12:08.750067Z","steps":["trace[1975693890] 'process raft request'  (duration: 117.54095ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:12:08.750673Z","caller":"traceutil/trace.go:171","msg":"trace[1781256487] transaction","detail":"{read_only:false; response_revision:4859; number_of_response:1; }","duration":"108.536022ms","start":"2026-08-05T11:12:08.642108Z","end":"2026-08-05T11:12:08.750644Z","steps":["trace[1781256487] 'process raft request'  (duration: 107.569027ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:12:12.896595Z","caller":"traceutil/trace.go:171","msg":"trace[1333561101] transaction","detail":"{read_only:false; response_revision:5007; number_of_response:1; }","duration":"129.786392ms","start":"2026-08-05T11:12:12.766783Z","end":"2026-08-05T11:12:12.89657Z","steps":["trace[1333561101] 'process raft request'  (duration: 129.587137ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:12:13.050175Z","caller":"traceutil/trace.go:171","msg":"trace[2135056302] linearizableReadLoop","detail":"{readStateIndex:5193; appliedIndex:5191; }","duration":"178.418535ms","start":"2026-08-05T11:12:12.87173Z","end":"2026-08-05T11:12:13.050148Z","steps":["trace[2135056302] 'read index received'  (duration: 24.703692ms)","trace[2135056302] 'applied index is now lower than readState.Index'  (duration: 153.713683ms)"],"step_count":2}
{"level":"info","ts":"2026-08-05T11:12:13.050313Z","caller":"traceutil/trace.go:171","msg":"trace[278918660] transaction","detail":"{read_only:false; response_revision:5008; number_of_response:1; }","duration":"282.703045ms","start":"2026-08-05T11:12:12.7676Z","end":"2026-08-05T11:12:13.050303Z","steps":["trace[278918660] 'process raft request'  (duration: 282.371426ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:12:13.050502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.191486ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-fzhnt\" ","response":"range_response_count:1 size:6530"}
{"level":"info","ts":"2026-08-05T11:12:13.050578Z","caller":"traceutil/trace.go:171","msg":"trace[1908797350] range","detail":"{range_begin:/registry/pods/openstack/keepalived-fzhnt; range_end:; response_count:1; response_revision:5008; }","duration":"110.277528ms","start":"2026-08-05T11:12:12.940283Z","end":"2026-08-05T11:12:13.050561Z","steps":["trace[1908797350] 'agreement among raft nodes before linearized reading'  (duration: 110.079743ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:12:13.050901Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.129543ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-43c7202f-d048-407d-b8ce-49aecc841f96\" ","response":"range_response_count:1 size:3601"}
{"level":"info","ts":"2026-08-05T11:12:13.051044Z","caller":"traceutil/trace.go:171","msg":"trace[1635219368] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-43c7202f-d048-407d-b8ce-49aecc841f96; range_end:; response_count:1; response_revision:5008; }","duration":"179.336989ms","start":"2026-08-05T11:12:12.871676Z","end":"2026-08-05T11:12:13.051013Z","steps":["trace[1635219368] 'agreement among raft nodes before linearized reading'  (duration: 178.898587ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:12:13.388646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.577933ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3415874564932295853 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/cert-manager/cert-manager-controller\" mod_revision:4300 > success:<request_put:<key:\"/registry/leases/cert-manager/cert-manager-controller\" value_size:452 >> failure:<request_range:<key:\"/registry/leases/cert-manager/cert-manager-controller\" > >>","response":"size:16"}
{"level":"info","ts":"2026-08-05T11:12:13.388763Z","caller":"traceutil/trace.go:171","msg":"trace[135256145] linearizableReadLoop","detail":"{readStateIndex:5196; appliedIndex:5195; }","duration":"100.254784ms","start":"2026-08-05T11:12:13.288491Z","end":"2026-08-05T11:12:13.388746Z","steps":["trace[135256145] 'read index received'  (duration: 79.672µs)","trace[135256145] 'applied index is now lower than readState.Index'  (duration: 100.173592ms)"],"step_count":2}
{"level":"info","ts":"2026-08-05T11:12:13.388836Z","caller":"traceutil/trace.go:171","msg":"trace[541289297] transaction","detail":"{read_only:false; response_revision:5011; number_of_response:1; }","duration":"156.902997ms","start":"2026-08-05T11:12:13.231904Z","end":"2026-08-05T11:12:13.388807Z","steps":["trace[541289297] 'process raft request'  (duration: 55.888713ms)","trace[541289297] 'compare'  (duration: 100.436729ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-05T11:12:13.388888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.394317ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/schemareplications/\" range_end:\"/registry/rabbitmq.com/schemareplications0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-05T11:12:13.388922Z","caller":"traceutil/trace.go:171","msg":"trace[437954116] range","detail":"{range_begin:/registry/rabbitmq.com/schemareplications/; range_end:/registry/rabbitmq.com/schemareplications0; response_count:0; response_revision:5011; }","duration":"100.543052ms","start":"2026-08-05T11:12:13.288367Z","end":"2026-08-05T11:12:13.38891Z","steps":["trace[437954116] 'agreement among raft nodes before linearized reading'  (duration: 100.47839ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:12:25.427419Z","caller":"traceutil/trace.go:171","msg":"trace[129844477] linearizableReadLoop","detail":"{readStateIndex:5442; appliedIndex:5441; }","duration":"300.039232ms","start":"2026-08-05T11:12:25.127353Z","end":"2026-08-05T11:12:25.427392Z","steps":["trace[129844477] 'read index received'  (duration: 299.884198ms)","trace[129844477] 'applied index is now lower than readState.Index'  (duration: 153.884µs)"],"step_count":2}
{"level":"info","ts":"2026-08-05T11:12:25.427533Z","caller":"traceutil/trace.go:171","msg":"trace[1971025937] transaction","detail":"{read_only:false; response_revision:5250; number_of_response:1; }","duration":"312.647705ms","start":"2026-08-05T11:12:25.114851Z","end":"2026-08-05T11:12:25.427499Z","steps":["trace[1971025937] 'process raft request'  (duration: 312.343827ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:12:25.427722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.352ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-fzhnt\" ","response":"range_response_count:1 size:6530"}
{"level":"warn","ts":"2026-08-05T11:12:25.42771Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T11:12:25.114821Z","time spent":"312.795359ms","remote":"127.0.0.1:46226","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:5197 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:458 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"info","ts":"2026-08-05T11:12:25.427774Z","caller":"traceutil/trace.go:171","msg":"trace[1206315893] range","detail":"{range_begin:/registry/pods/openstack/keepalived-fzhnt; range_end:; response_count:1; response_revision:5250; }","duration":"300.469594ms","start":"2026-08-05T11:12:25.127289Z","end":"2026-08-05T11:12:25.427759Z","steps":["trace[1206315893] 'agreement among raft nodes before linearized reading'  (duration: 300.267608ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:12:25.427814Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T11:12:25.127269Z","time spent":"300.536825ms","remote":"127.0.0.1:46156","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6553,"request content":"key:\"/registry/pods/openstack/keepalived-fzhnt\" "}
{"level":"warn","ts":"2026-08-05T11:12:25.4278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.131979ms","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-05T11:12:25.427877Z","caller":"traceutil/trace.go:171","msg":"trace[610738639] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5250; }","duration":"183.258252ms","start":"2026-08-05T11:12:25.244604Z","end":"2026-08-05T11:12:25.427862Z","steps":["trace[610738639] 'agreement among raft nodes before linearized reading'  (duration: 183.013226ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:12:25.4278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.592311ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/memcached-memcached-6479589586-2wfb2\" ","response":"range_response_count:1 size:7818"}
{"level":"info","ts":"2026-08-05T11:12:25.427955Z","caller":"traceutil/trace.go:171","msg":"trace[801148681] range","detail":"{range_begin:/registry/pods/openstack/memcached-memcached-6479589586-2wfb2; range_end:; response_count:1; response_revision:5250; }","duration":"208.802976ms","start":"2026-08-05T11:12:25.21914Z","end":"2026-08-05T11:12:25.427943Z","steps":["trace[801148681] 'agreement among raft nodes before linearized reading'  (duration: 208.473948ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:12:33.498979Z","caller":"traceutil/trace.go:171","msg":"trace[1505065189] transaction","detail":"{read_only:false; response_revision:5431; number_of_response:1; }","duration":"131.94275ms","start":"2026-08-05T11:12:33.367004Z","end":"2026-08-05T11:12:33.498947Z","steps":["trace[1505065189] 'process raft request'  (duration: 82.757183ms)","trace[1505065189] 'compare'  (duration: 49.040933ms)"],"step_count":2}
{"level":"info","ts":"2026-08-05T11:12:33.500069Z","caller":"traceutil/trace.go:171","msg":"trace[575971848] transaction","detail":"{read_only:false; response_revision:5432; number_of_response:1; }","duration":"132.7064ms","start":"2026-08-05T11:12:33.367349Z","end":"2026-08-05T11:12:33.500056Z","steps":["trace[575971848] 'process raft request'  (duration: 132.513785ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:12:33.500377Z","caller":"traceutil/trace.go:171","msg":"trace[487241626] transaction","detail":"{read_only:false; response_revision:5433; number_of_response:1; }","duration":"132.278048ms","start":"2026-08-05T11:12:33.368074Z","end":"2026-08-05T11:12:33.500352Z","steps":["trace[487241626] 'process raft request'  (duration: 131.882917ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:12:33.500868Z","caller":"traceutil/trace.go:171","msg":"trace[1179668638] transaction","detail":"{read_only:false; response_revision:5434; number_of_response:1; }","duration":"132.664649ms","start":"2026-08-05T11:12:33.368182Z","end":"2026-08-05T11:12:33.500847Z","steps":["trace[1179668638] 'process raft request'  (duration: 132.082273ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:12:33.501078Z","caller":"traceutil/trace.go:171","msg":"trace[1854227500] transaction","detail":"{read_only:false; response_revision:5435; number_of_response:1; }","duration":"132.667989ms","start":"2026-08-05T11:12:33.368369Z","end":"2026-08-05T11:12:33.501037Z","steps":["trace[1854227500] 'process raft request'  (duration: 132.3184ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:12:33.501723Z","caller":"traceutil/trace.go:171","msg":"trace[198755955] transaction","detail":"{read_only:false; response_revision:5436; number_of_response:1; }","duration":"132.813013ms","start":"2026-08-05T11:12:33.368861Z","end":"2026-08-05T11:12:33.501674Z","steps":["trace[198755955] 'process raft request'  (duration: 132.077523ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:12:33.501892Z","caller":"traceutil/trace.go:171","msg":"trace[1267183223] transaction","detail":"{read_only:false; response_revision:5437; number_of_response:1; }","duration":"128.869648ms","start":"2026-08-05T11:12:33.372993Z","end":"2026-08-05T11:12:33.501863Z","steps":["trace[1267183223] 'process raft request'  (duration: 128.386886ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:13:53.65097Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3017}
{"level":"info","ts":"2026-08-05T11:13:53.739297Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3017,"took":"87.073791ms","hash":2932647740,"current-db-size-bytes":59686912,"current-db-size":"60 MB","current-db-size-in-use-bytes":32378880,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-08-05T11:13:53.739367Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2932647740,"revision":3017,"compact-revision":-1}
{"level":"info","ts":"2026-08-05T11:18:01.621132Z","caller":"traceutil/trace.go:171","msg":"trace[283035469] transaction","detail":"{read_only:false; response_revision:7842; number_of_response:1; }","duration":"118.758632ms","start":"2026-08-05T11:18:01.502287Z","end":"2026-08-05T11:18:01.621045Z","steps":["trace[283035469] 'process raft request'  (duration: 53.360146ms)","trace[283035469] 'compare'  (duration: 65.041517ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-05T11:18:52.537964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.686802ms","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-05T11:18:52.538065Z","caller":"traceutil/trace.go:171","msg":"trace[1243725859] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8311; }","duration":"324.843686ms","start":"2026-08-05T11:18:52.213202Z","end":"2026-08-05T11:18:52.538046Z","steps":["trace[1243725859] 'range keys from in-memory index tree'  (duration: 324.562888ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:18:52.538032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.76087ms","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-05T11:18:52.538116Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T11:18:52.213183Z","time spent":"324.921547ms","remote":"127.0.0.1:46226","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-08-05T11:18:52.538137Z","caller":"traceutil/trace.go:171","msg":"trace[1883887404] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8311; }","duration":"319.887234ms","start":"2026-08-05T11:18:52.218229Z","end":"2026-08-05T11:18:52.538117Z","steps":["trace[1883887404] 'range keys from in-memory index tree'  (duration: 319.428682ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:18:52.538185Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T11:18:52.218218Z","time spent":"319.954605ms","remote":"127.0.0.1:46226","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-08-05T11:18:52.71776Z","caller":"traceutil/trace.go:171","msg":"trace[1886385281] linearizableReadLoop","detail":"{readStateIndex:8602; appliedIndex:8600; }","duration":"156.190177ms","start":"2026-08-05T11:18:52.561545Z","end":"2026-08-05T11:18:52.717736Z","steps":["trace[1886385281] 'read index received'  (duration: 155.948461ms)","trace[1886385281] 'applied index is now lower than readState.Index'  (duration: 240.676µs)"],"step_count":2}
{"level":"info","ts":"2026-08-05T11:18:52.717822Z","caller":"traceutil/trace.go:171","msg":"trace[654850111] transaction","detail":"{read_only:false; response_revision:8313; number_of_response:1; }","duration":"176.082005ms","start":"2026-08-05T11:18:52.54169Z","end":"2026-08-05T11:18:52.717772Z","steps":["trace[654850111] 'process raft request'  (duration: 175.837289ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:18:52.717835Z","caller":"traceutil/trace.go:171","msg":"trace[1275766511] transaction","detail":"{read_only:false; response_revision:8314; number_of_response:1; }","duration":"173.61314ms","start":"2026-08-05T11:18:52.544183Z","end":"2026-08-05T11:18:52.717796Z","steps":["trace[1275766511] 'process raft request'  (duration: 173.509557ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:18:52.717945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.371782ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-05T11:18:52.718037Z","caller":"traceutil/trace.go:171","msg":"trace[857997949] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8314; }","duration":"156.524686ms","start":"2026-08-05T11:18:52.561489Z","end":"2026-08-05T11:18:52.718014Z","steps":["trace[857997949] 'agreement among raft nodes before linearized reading'  (duration: 156.359451ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:18:53.656369Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6151}
{"level":"info","ts":"2026-08-05T11:18:53.772536Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6151,"took":"114.10661ms","hash":118188833,"current-db-size-bytes":59686912,"current-db-size":"60 MB","current-db-size-in-use-bytes":23592960,"current-db-size-in-use":"24 MB"}
{"level":"info","ts":"2026-08-05T11:18:53.772592Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":118188833,"revision":6151,"compact-revision":3017}
{"level":"info","ts":"2026-08-05T11:19:03.622359Z","caller":"traceutil/trace.go:171","msg":"trace[2025657228] transaction","detail":"{read_only:false; response_revision:8371; number_of_response:1; }","duration":"140.781398ms","start":"2026-08-05T11:19:03.481544Z","end":"2026-08-05T11:19:03.622326Z","steps":["trace[2025657228] 'process raft request'  (duration: 140.040198ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:19:03.958796Z","caller":"traceutil/trace.go:171","msg":"trace[1328390627] transaction","detail":"{read_only:false; response_revision:8372; number_of_response:1; }","duration":"132.130049ms","start":"2026-08-05T11:19:03.826647Z","end":"2026-08-05T11:19:03.958777Z","steps":["trace[1328390627] 'process raft request'  (duration: 127.425854ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:19:03.959965Z","caller":"traceutil/trace.go:171","msg":"trace[1123045091] transaction","detail":"{read_only:false; response_revision:8373; number_of_response:1; }","duration":"126.285373ms","start":"2026-08-05T11:19:03.833668Z","end":"2026-08-05T11:19:03.959954Z","steps":["trace[1123045091] 'process raft request'  (duration: 126.210991ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:19:04.730432Z","caller":"traceutil/trace.go:171","msg":"trace[2141342345] linearizableReadLoop","detail":"{readStateIndex:8666; appliedIndex:8665; }","duration":"113.619177ms","start":"2026-08-05T11:19:04.616787Z","end":"2026-08-05T11:19:04.730406Z","steps":["trace[2141342345] 'read index received'  (duration: 113.448133ms)","trace[2141342345] 'applied index is now lower than readState.Index'  (duration: 170.004µs)"],"step_count":2}
{"level":"warn","ts":"2026-08-05T11:19:04.730565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.759561ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-05T11:19:04.730545Z","caller":"traceutil/trace.go:171","msg":"trace[871839358] transaction","detail":"{read_only:false; response_revision:8375; number_of_response:1; }","duration":"123.075658ms","start":"2026-08-05T11:19:04.607434Z","end":"2026-08-05T11:19:04.73051Z","steps":["trace[871839358] 'process raft request'  (duration: 122.797261ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:19:04.730607Z","caller":"traceutil/trace.go:171","msg":"trace[1111027271] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:8375; }","duration":"113.866413ms","start":"2026-08-05T11:19:04.616728Z","end":"2026-08-05T11:19:04.730594Z","steps":["trace[1111027271] 'agreement among raft nodes before linearized reading'  (duration: 113.776871ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:19:05.974735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.262479ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/objectbucket.io/objectbucketclaims/\" range_end:\"/registry/objectbucket.io/objectbucketclaims0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-05T11:19:05.974839Z","caller":"traceutil/trace.go:171","msg":"trace[872450852] range","detail":"{range_begin:/registry/objectbucket.io/objectbucketclaims/; range_end:/registry/objectbucket.io/objectbucketclaims0; response_count:0; response_revision:8380; }","duration":"115.391312ms","start":"2026-08-05T11:19:05.859422Z","end":"2026-08-05T11:19:05.974813Z","steps":["trace[872450852] 'range keys from in-memory index tree'  (duration: 115.214888ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:19:05.974849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.033944ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/objectbucket.io/objectbucketclaims/\" range_end:\"/registry/objectbucket.io/objectbucketclaims0\" limit:500 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-05T11:19:05.974958Z","caller":"traceutil/trace.go:171","msg":"trace[1118313134] range","detail":"{range_begin:/registry/objectbucket.io/objectbucketclaims/; range_end:/registry/objectbucket.io/objectbucketclaims0; response_count:0; response_revision:8380; }","duration":"115.206298ms","start":"2026-08-05T11:19:05.859729Z","end":"2026-08-05T11:19:05.974935Z","steps":["trace[1118313134] 'range keys from in-memory index tree'  (duration: 114.973002ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:19:05.974849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.655016ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephbucketnotifications/\" range_end:\"/registry/ceph.rook.io/cephbucketnotifications0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-08-05T11:19:05.975022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.495425ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/objectbucket.io/objectbucketclaims/\" range_end:\"/registry/objectbucket.io/objectbucketclaims0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-05T11:19:05.975082Z","caller":"traceutil/trace.go:171","msg":"trace[1058951945] range","detail":"{range_begin:/registry/objectbucket.io/objectbucketclaims/; range_end:/registry/objectbucket.io/objectbucketclaims0; response_count:0; response_revision:8380; }","duration":"115.595818ms","start":"2026-08-05T11:19:05.859473Z","end":"2026-08-05T11:19:05.975069Z","steps":["trace[1058951945] 'count revisions from in-memory index tree'  (duration: 115.413874ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:19:05.975091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.096146ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephbucketnotifications/\" range_end:\"/registry/ceph.rook.io/cephbucketnotifications0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-05T11:19:05.975122Z","caller":"traceutil/trace.go:171","msg":"trace[142790176] range","detail":"{range_begin:/registry/ceph.rook.io/cephbucketnotifications/; range_end:/registry/ceph.rook.io/cephbucketnotifications0; response_count:0; response_revision:8380; }","duration":"129.151078ms","start":"2026-08-05T11:19:05.845963Z","end":"2026-08-05T11:19:05.975114Z","steps":["trace[142790176] 'range keys from in-memory index tree'  (duration: 129.042355ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:19:05.975042Z","caller":"traceutil/trace.go:171","msg":"trace[1324365350] range","detail":"{range_begin:/registry/ceph.rook.io/cephbucketnotifications/; range_end:/registry/ceph.rook.io/cephbucketnotifications0; response_count:0; response_revision:8380; }","duration":"128.899402ms","start":"2026-08-05T11:19:05.846126Z","end":"2026-08-05T11:19:05.975026Z","steps":["trace[1324365350] 'count revisions from in-memory index tree'  (duration: 128.595313ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:19:05.975144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.591377ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephbucketnotifications/\" range_end:\"/registry/ceph.rook.io/cephbucketnotifications0\" limit:500 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-05T11:19:05.975213Z","caller":"traceutil/trace.go:171","msg":"trace[1591923020] range","detail":"{range_begin:/registry/ceph.rook.io/cephbucketnotifications/; range_end:/registry/ceph.rook.io/cephbucketnotifications0; response_count:0; response_revision:8380; }","duration":"127.716011ms","start":"2026-08-05T11:19:05.847481Z","end":"2026-08-05T11:19:05.975197Z","steps":["trace[1591923020] 'range keys from in-memory index tree'  (duration: 127.538555ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:19:32.557376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.897116ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3415874564932305099 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:8566 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >>","response":"size:16"}
{"level":"info","ts":"2026-08-05T11:19:32.557443Z","caller":"traceutil/trace.go:171","msg":"trace[1836254831] linearizableReadLoop","detail":"{readStateIndex:8877; appliedIndex:8876; }","duration":"161.981171ms","start":"2026-08-05T11:19:32.395453Z","end":"2026-08-05T11:19:32.557434Z","steps":["trace[1836254831] 'read index received'  (duration: 28.891µs)","trace[1836254831] 'applied index is now lower than readState.Index'  (duration: 161.95095ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-05T11:19:32.55753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.085184ms","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-05T11:19:32.557545Z","caller":"traceutil/trace.go:171","msg":"trace[960499666] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8578; }","duration":"162.135515ms","start":"2026-08-05T11:19:32.395405Z","end":"2026-08-05T11:19:32.55754Z","steps":["trace[960499666] 'agreement among raft nodes before linearized reading'  (duration: 162.053803ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:19:32.55767Z","caller":"traceutil/trace.go:171","msg":"trace[29909538] transaction","detail":"{read_only:false; response_revision:8578; number_of_response:1; }","duration":"458.103584ms","start":"2026-08-05T11:19:32.099561Z","end":"2026-08-05T11:19:32.557664Z","steps":["trace[29909538] 'process raft request'  (duration: 268.88923ms)","trace[29909538] 'compare'  (duration: 188.529886ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-05T11:19:32.557698Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T11:19:32.099543Z","time spent":"458.139855ms","remote":"127.0.0.1:46226","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:8566 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-08-05T11:19:36.730685Z","caller":"traceutil/trace.go:171","msg":"trace[29882346] linearizableReadLoop","detail":"{readStateIndex:8895; appliedIndex:8894; }","duration":"156.006393ms","start":"2026-08-05T11:19:36.57466Z","end":"2026-08-05T11:19:36.730666Z","steps":["trace[29882346] 'read index received'  (duration: 155.815877ms)","trace[29882346] 'applied index is now lower than readState.Index'  (duration: 189.816µs)"],"step_count":2}
{"level":"info","ts":"2026-08-05T11:19:36.730733Z","caller":"traceutil/trace.go:171","msg":"trace[376316592] transaction","detail":"{read_only:false; response_revision:8596; number_of_response:1; }","duration":"159.636519ms","start":"2026-08-05T11:19:36.571074Z","end":"2026-08-05T11:19:36.73071Z","steps":["trace[376316592] 'process raft request'  (duration: 159.468414ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:19:36.730857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.190127ms","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-05T11:19:36.730884Z","caller":"traceutil/trace.go:171","msg":"trace[1836711236] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8596; }","duration":"156.230638ms","start":"2026-08-05T11:19:36.574645Z","end":"2026-08-05T11:19:36.730876Z","steps":["trace[1836711236] 'agreement among raft nodes before linearized reading'  (duration: 156.093544ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:19:44.740294Z","caller":"traceutil/trace.go:171","msg":"trace[812352252] linearizableReadLoop","detail":"{readStateIndex:8983; appliedIndex:8982; }","duration":"144.289662ms","start":"2026-08-05T11:19:44.595987Z","end":"2026-08-05T11:19:44.740277Z","steps":["trace[812352252] 'read index received'  (duration: 87.296788ms)","trace[812352252] 'applied index is now lower than readState.Index'  (duration: 56.991824ms)"],"step_count":2}
{"level":"info","ts":"2026-08-05T11:19:44.740635Z","caller":"traceutil/trace.go:171","msg":"trace[1821799654] transaction","detail":"{read_only:false; response_revision:8679; number_of_response:1; }","duration":"147.913287ms","start":"2026-08-05T11:19:44.592679Z","end":"2026-08-05T11:19:44.740592Z","steps":["trace[1821799654] 'process raft request'  (duration: 90.697128ms)","trace[1821799654] 'compare'  (duration: 56.794458ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-05T11:19:44.740681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.655512ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/openstack/rook-ceph-detect-version-tnx9n\" ","response":"range_response_count:1 size:2804"}
{"level":"info","ts":"2026-08-05T11:19:44.740784Z","caller":"traceutil/trace.go:171","msg":"trace[1520821387] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/openstack/rook-ceph-detect-version-tnx9n; range_end:; response_count:1; response_revision:8679; }","duration":"144.798455ms","start":"2026-08-05T11:19:44.595962Z","end":"2026-08-05T11:19:44.74076Z","steps":["trace[1520821387] 'agreement among raft nodes before linearized reading'  (duration: 144.428055ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:19:45.023784Z","caller":"traceutil/trace.go:171","msg":"trace[1016377342] linearizableReadLoop","detail":"{readStateIndex:8984; appliedIndex:8983; }","duration":"279.04208ms","start":"2026-08-05T11:19:44.744714Z","end":"2026-08-05T11:19:45.023756Z","steps":["trace[1016377342] 'read index received'  (duration: 260.608531ms)","trace[1016377342] 'applied index is now lower than readState.Index'  (duration: 18.432429ms)"],"step_count":2}
{"level":"info","ts":"2026-08-05T11:19:45.023813Z","caller":"traceutil/trace.go:171","msg":"trace[1430180668] transaction","detail":"{read_only:false; number_of_response:1; response_revision:8680; }","duration":"279.898143ms","start":"2026-08-05T11:19:44.743883Z","end":"2026-08-05T11:19:45.023781Z","steps":["trace[1430180668] 'process raft request'  (duration: 261.34688ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:19:45.024107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.373989ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-tnx9n\" ","response":"range_response_count:1 size:4648"}
{"level":"info","ts":"2026-08-05T11:19:45.02415Z","caller":"traceutil/trace.go:171","msg":"trace[2066498370] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-tnx9n; range_end:; response_count:1; response_revision:8681; }","duration":"279.45834ms","start":"2026-08-05T11:19:44.744679Z","end":"2026-08-05T11:19:45.024137Z","steps":["trace[2066498370] 'agreement among raft nodes before linearized reading'  (duration: 279.254745ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:19:45.024149Z","caller":"traceutil/trace.go:171","msg":"trace[839572133] transaction","detail":"{read_only:false; response_revision:8681; number_of_response:1; }","duration":"267.853703ms","start":"2026-08-05T11:19:44.75626Z","end":"2026-08-05T11:19:45.024114Z","steps":["trace[839572133] 'process raft request'  (duration: 267.39327ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:19:45.02455Z","caller":"traceutil/trace.go:171","msg":"trace[1663655385] transaction","detail":"{read_only:false; response_revision:8682; number_of_response:1; }","duration":"238.398701ms","start":"2026-08-05T11:19:44.78613Z","end":"2026-08-05T11:19:45.024529Z","steps":["trace[1663655385] 'process raft request'  (duration: 237.864326ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:19:45.024625Z","caller":"traceutil/trace.go:171","msg":"trace[731915903] transaction","detail":"{read_only:false; response_revision:8683; number_of_response:1; }","duration":"228.776815ms","start":"2026-08-05T11:19:44.795831Z","end":"2026-08-05T11:19:45.024608Z","steps":["trace[731915903] 'process raft request'  (duration: 228.564229ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:19:45.024722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.679838ms","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-05T11:19:45.024752Z","caller":"traceutil/trace.go:171","msg":"trace[155152265] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8684; }","duration":"212.738369ms","start":"2026-08-05T11:19:44.812006Z","end":"2026-08-05T11:19:45.024744Z","steps":["trace[155152265] 'agreement among raft nodes before linearized reading'  (duration: 212.652897ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:19:45.024794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.085021ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-43c7202f-d048-407d-b8ce-49aecc841f96\" ","response":"range_response_count:1 size:1275"}
{"level":"info","ts":"2026-08-05T11:19:45.024896Z","caller":"traceutil/trace.go:171","msg":"trace[916948448] range","detail":"{range_begin:/registry/persistentvolumes/pvc-43c7202f-d048-407d-b8ce-49aecc841f96; range_end:; response_count:1; response_revision:8684; }","duration":"279.207814ms","start":"2026-08-05T11:19:44.745662Z","end":"2026-08-05T11:19:45.02487Z","steps":["trace[916948448] 'agreement among raft nodes before linearized reading'  (duration: 278.954027ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:19:45.024828Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.620677ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-tnx9n\" ","response":"range_response_count:1 size:4648"}
{"level":"info","ts":"2026-08-05T11:19:45.025075Z","caller":"traceutil/trace.go:171","msg":"trace[1509805192] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-tnx9n; range_end:; response_count:1; response_revision:8684; }","duration":"229.912915ms","start":"2026-08-05T11:19:44.795145Z","end":"2026-08-05T11:19:45.025058Z","steps":["trace[1509805192] 'agreement among raft nodes before linearized reading'  (duration: 229.529035ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:19:45.867205Z","caller":"traceutil/trace.go:171","msg":"trace[1202420341] transaction","detail":"{read_only:false; response_revision:8692; number_of_response:1; }","duration":"135.271073ms","start":"2026-08-05T11:19:45.73191Z","end":"2026-08-05T11:19:45.867181Z","steps":["trace[1202420341] 'process raft request'  (duration: 134.647616ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:19:59.158713Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002391.wal"}
{"level":"info","ts":"2026-08-05T11:21:05.499412Z","caller":"traceutil/trace.go:171","msg":"trace[1080891483] linearizableReadLoop","detail":"{readStateIndex:9780; appliedIndex:9779; }","duration":"171.947736ms","start":"2026-08-05T11:21:05.327437Z","end":"2026-08-05T11:21:05.499385Z","steps":["trace[1080891483] 'read index received'  (duration: 103.231921ms)","trace[1080891483] 'applied index is now lower than readState.Index'  (duration: 68.712655ms)"],"step_count":2}
{"level":"info","ts":"2026-08-05T11:21:05.499606Z","caller":"traceutil/trace.go:171","msg":"trace[23440128] transaction","detail":"{read_only:false; response_revision:9455; number_of_response:1; }","duration":"209.063101ms","start":"2026-08-05T11:21:05.290338Z","end":"2026-08-05T11:21:05.499401Z","steps":["trace[23440128] 'process raft request'  (duration: 140.332496ms)","trace[23440128] 'compare'  (duration: 67.936184ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-05T11:21:05.499749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.201712ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-05T11:21:05.499874Z","caller":"traceutil/trace.go:171","msg":"trace[1472874949] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:9456; }","duration":"172.460629ms","start":"2026-08-05T11:21:05.327392Z","end":"2026-08-05T11:21:05.499853Z","steps":["trace[1472874949] 'agreement among raft nodes before linearized reading'  (duration: 172.194382ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:21:05.651417Z","caller":"traceutil/trace.go:171","msg":"trace[878318009] transaction","detail":"{read_only:false; response_revision:9459; number_of_response:1; }","duration":"103.578871ms","start":"2026-08-05T11:21:05.54779Z","end":"2026-08-05T11:21:05.651369Z","steps":["trace[878318009] 'process raft request'  (duration: 74.21044ms)","trace[878318009] 'compare'  (duration: 29.096603ms)"],"step_count":2}
{"level":"info","ts":"2026-08-05T11:21:35.61281Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"39582465ceaa2f67","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-08-05T11:21:35.617736Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-08-05T11:21:35.617817Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-08-05T11:23:53.663856Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8318}
{"level":"info","ts":"2026-08-05T11:23:53.750433Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8318,"took":"83.97928ms","hash":120001794,"current-db-size-bytes":59686912,"current-db-size":"60 MB","current-db-size-in-use-bytes":24760320,"current-db-size-in-use":"25 MB"}
{"level":"info","ts":"2026-08-05T11:23:53.750529Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":120001794,"revision":8318,"compact-revision":6151}
{"level":"info","ts":"2026-08-05T11:26:20.689105Z","caller":"traceutil/trace.go:171","msg":"trace[178515195] transaction","detail":"{read_only:false; response_revision:11760; number_of_response:1; }","duration":"137.072622ms","start":"2026-08-05T11:26:20.552001Z","end":"2026-08-05T11:26:20.689073Z","steps":["trace[178515195] 'process raft request'  (duration: 136.796894ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:26:20.689012Z","caller":"traceutil/trace.go:171","msg":"trace[1528059668] linearizableReadLoop","detail":"{readStateIndex:12158; appliedIndex:12157; }","duration":"130.022912ms","start":"2026-08-05T11:26:20.558948Z","end":"2026-08-05T11:26:20.688971Z","steps":["trace[1528059668] 'read index received'  (duration: 129.884498ms)","trace[1528059668] 'applied index is now lower than readState.Index'  (duration: 136.844µs)"],"step_count":2}
{"level":"warn","ts":"2026-08-05T11:26:20.689243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.273019ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-05T11:26:20.689316Z","caller":"traceutil/trace.go:171","msg":"trace[993992723] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:11760; }","duration":"130.397293ms","start":"2026-08-05T11:26:20.558903Z","end":"2026-08-05T11:26:20.6893Z","steps":["trace[993992723] 'agreement among raft nodes before linearized reading'  (duration: 130.250079ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:26:38.187148Z","caller":"traceutil/trace.go:171","msg":"trace[1737509644] linearizableReadLoop","detail":"{readStateIndex:12258; appliedIndex:12257; }","duration":"201.350837ms","start":"2026-08-05T11:26:37.985773Z","end":"2026-08-05T11:26:38.187124Z","steps":["trace[1737509644] 'read index received'  (duration: 201.118461ms)","trace[1737509644] 'applied index is now lower than readState.Index'  (duration: 231.496µs)"],"step_count":2}
{"level":"info","ts":"2026-08-05T11:26:38.187276Z","caller":"traceutil/trace.go:171","msg":"trace[88226985] transaction","detail":"{read_only:false; response_revision:11856; number_of_response:1; }","duration":"227.606543ms","start":"2026-08-05T11:26:37.959627Z","end":"2026-08-05T11:26:38.187233Z","steps":["trace[88226985] 'process raft request'  (duration: 227.322116ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:26:38.187393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.600795ms","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-05T11:26:38.187457Z","caller":"traceutil/trace.go:171","msg":"trace[1273480819] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:11856; }","duration":"201.714357ms","start":"2026-08-05T11:26:37.985731Z","end":"2026-08-05T11:26:38.187445Z","steps":["trace[1273480819] 'agreement among raft nodes before linearized reading'  (duration: 201.502171ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:26:38.310641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.528425ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3415874564932313845 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:11845 > 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-05T11:26:38.310863Z","caller":"traceutil/trace.go:171","msg":"trace[1696884258] transaction","detail":"{read_only:false; response_revision:11857; number_of_response:1; }","duration":"118.603986ms","start":"2026-08-05T11:26:38.192229Z","end":"2026-08-05T11:26:38.310833Z","steps":["trace[1696884258] 'process raft request'  (duration: 12.781624ms)","trace[1696884258] 'compare'  (duration: 105.355349ms)"],"step_count":2}
{"level":"info","ts":"2026-08-05T11:26:38.310898Z","caller":"traceutil/trace.go:171","msg":"trace[1983051600] linearizableReadLoop","detail":"{readStateIndex:12260; appliedIndex:12258; }","duration":"117.151336ms","start":"2026-08-05T11:26:38.193733Z","end":"2026-08-05T11:26:38.310884Z","steps":["trace[1983051600] 'read index received'  (duration: 11.251142ms)","trace[1983051600] 'applied index is now lower than readState.Index'  (duration: 105.896824ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-05T11:26:38.311046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.3094ms","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-05T11:26:38.311086Z","caller":"traceutil/trace.go:171","msg":"trace[2025836604] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:11858; }","duration":"117.348201ms","start":"2026-08-05T11:26:38.193726Z","end":"2026-08-05T11:26:38.311074Z","steps":["trace[2025836604] 'agreement among raft nodes before linearized reading'  (duration: 117.202657ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:26:38.311179Z","caller":"traceutil/trace.go:171","msg":"trace[1005075504] transaction","detail":"{read_only:false; response_revision:11858; number_of_response:1; }","duration":"117.769584ms","start":"2026-08-05T11:26:38.19335Z","end":"2026-08-05T11:26:38.311119Z","steps":["trace[1005075504] 'process raft request'  (duration: 117.404124ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:26:39.174743Z","caller":"traceutil/trace.go:171","msg":"trace[751081337] transaction","detail":"{read_only:false; response_revision:11863; number_of_response:1; }","duration":"260.965809ms","start":"2026-08-05T11:26:38.913755Z","end":"2026-08-05T11:26:39.174721Z","steps":["trace[751081337] 'process raft request'  (duration: 260.820215ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:28:53.71097Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10538}
{"level":"info","ts":"2026-08-05T11:28:53.812713Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10538,"took":"98.372162ms","hash":1152186612,"current-db-size-bytes":59686912,"current-db-size":"60 MB","current-db-size-in-use-bytes":26349568,"current-db-size-in-use":"26 MB"}
{"level":"info","ts":"2026-08-05T11:28:53.812791Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1152186612,"revision":10538,"compact-revision":8318}
{"level":"info","ts":"2026-08-05T11:31:22.53315Z","caller":"traceutil/trace.go:171","msg":"trace[147795257] transaction","detail":"{read_only:false; response_revision:13802; number_of_response:1; }","duration":"105.019602ms","start":"2026-08-05T11:31:22.428104Z","end":"2026-08-05T11:31:22.533123Z","steps":["trace[147795257] 'process raft request'  (duration: 104.867818ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:31:29.092253Z","caller":"traceutil/trace.go:171","msg":"trace[845103243] transaction","detail":"{read_only:false; response_revision:13840; number_of_response:1; }","duration":"107.649563ms","start":"2026-08-05T11:31:28.984564Z","end":"2026-08-05T11:31:29.092214Z","steps":["trace[845103243] 'process raft request'  (duration: 18.78666ms)","trace[845103243] 'compare'  (duration: 88.618886ms)"],"step_count":2}
{"level":"info","ts":"2026-08-05T11:32:45.797466Z","caller":"traceutil/trace.go:171","msg":"trace[71599166] transaction","detail":"{read_only:false; response_revision:14339; number_of_response:1; }","duration":"142.027379ms","start":"2026-08-05T11:32:45.655416Z","end":"2026-08-05T11:32:45.797444Z","steps":["trace[71599166] 'process raft request'  (duration: 141.765342ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:33:21.028719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.500315ms","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-05T11:33:21.028839Z","caller":"traceutil/trace.go:171","msg":"trace[1991163869] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:14542; }","duration":"129.68318ms","start":"2026-08-05T11:33:20.899132Z","end":"2026-08-05T11:33:21.028815Z","steps":["trace[1991163869] 'count revisions from in-memory index tree'  (duration: 129.376673ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:33:21.028936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.060473ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/exchanges/\" range_end:\"/registry/rabbitmq.com/exchanges0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-08-05T11:33:21.029029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.815822ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/openvswitch-99mcf\" ","response":"range_response_count:1 size:12364"}
{"level":"info","ts":"2026-08-05T11:33:21.029091Z","caller":"traceutil/trace.go:171","msg":"trace[451243327] range","detail":"{range_begin:/registry/pods/openstack/openvswitch-99mcf; range_end:; response_count:1; response_revision:14542; }","duration":"239.921604ms","start":"2026-08-05T11:33:20.789156Z","end":"2026-08-05T11:33:21.029077Z","steps":["trace[451243327] 'range keys from in-memory index tree'  (duration: 239.678938ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:33:21.029104Z","caller":"traceutil/trace.go:171","msg":"trace[272188538] range","detail":"{range_begin:/registry/rabbitmq.com/exchanges/; range_end:/registry/rabbitmq.com/exchanges0; response_count:0; response_revision:14542; }","duration":"262.293219ms","start":"2026-08-05T11:33:20.766776Z","end":"2026-08-05T11:33:21.029069Z","steps":["trace[272188538] 'count revisions from in-memory index tree'  (duration: 261.970061ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:33:21.029298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.929067ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-glance-server-0\" ","response":"range_response_count:1 size:1857"}
{"level":"info","ts":"2026-08-05T11:33:21.029377Z","caller":"traceutil/trace.go:171","msg":"trace[688929833] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-glance-server-0; range_end:; response_count:1; response_revision:14542; }","duration":"263.05121ms","start":"2026-08-05T11:33:20.766305Z","end":"2026-08-05T11:33:21.029357Z","steps":["trace[688929833] 'range keys from in-memory index tree'  (duration: 262.767922ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:33:21.206556Z","caller":"traceutil/trace.go:171","msg":"trace[1592872923] transaction","detail":"{read_only:false; response_revision:14543; number_of_response:1; }","duration":"166.691406ms","start":"2026-08-05T11:33:21.039837Z","end":"2026-08-05T11:33:21.206528Z","steps":["trace[1592872923] 'process raft request'  (duration: 166.545652ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:33:42.723721Z","caller":"traceutil/trace.go:171","msg":"trace[994475738] transaction","detail":"{read_only:false; response_revision:14848; number_of_response:1; }","duration":"226.62433ms","start":"2026-08-05T11:33:42.497078Z","end":"2026-08-05T11:33:42.723702Z","steps":["trace[994475738] 'process raft request'  (duration: 226.480047ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:33:42.80505Z","caller":"traceutil/trace.go:171","msg":"trace[2070661303] transaction","detail":"{read_only:false; response_revision:14849; number_of_response:1; }","duration":"304.181954ms","start":"2026-08-05T11:33:42.500834Z","end":"2026-08-05T11:33:42.805016Z","steps":["trace[2070661303] 'process raft request'  (duration: 303.934557ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:33:42.805126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.845018ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-05T11:33:42.805177Z","caller":"traceutil/trace.go:171","msg":"trace[1135032558] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:14849; }","duration":"243.944371ms","start":"2026-08-05T11:33:42.561223Z","end":"2026-08-05T11:33:42.805167Z","steps":["trace[1135032558] 'agreement among raft nodes before linearized reading'  (duration: 243.860109ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:33:42.805158Z","caller":"traceutil/trace.go:171","msg":"trace[1100682868] linearizableReadLoop","detail":"{readStateIndex:15359; appliedIndex:15357; }","duration":"243.629003ms","start":"2026-08-05T11:33:42.561276Z","end":"2026-08-05T11:33:42.804905Z","steps":["trace[1100682868] 'read index received'  (duration: 162.312269ms)","trace[1100682868] 'applied index is now lower than readState.Index'  (duration: 81.315554ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-05T11:33:42.805248Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T11:33:42.500825Z","time spent":"304.315917ms","remote":"127.0.0.1:46226","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:14775 > 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-05T11:33:42.811605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.681705ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/valkey-data-valkey-node-0\" ","response":"range_response_count:1 size:1633"}
{"level":"info","ts":"2026-08-05T11:33:42.811745Z","caller":"traceutil/trace.go:171","msg":"trace[599494441] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/valkey-data-valkey-node-0; range_end:; response_count:1; response_revision:14850; }","duration":"119.86119ms","start":"2026-08-05T11:33:42.691873Z","end":"2026-08-05T11:33:42.811734Z","steps":["trace[599494441] 'agreement among raft nodes before linearized reading'  (duration: 119.669275ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:33:42.811609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.0683ms","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-05T11:33:42.811849Z","caller":"traceutil/trace.go:171","msg":"trace[417989134] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:14850; }","duration":"204.334817ms","start":"2026-08-05T11:33:42.607499Z","end":"2026-08-05T11:33:42.811834Z","steps":["trace[417989134] 'agreement among raft nodes before linearized reading'  (duration: 204.031358ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:33:42.811669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.549568ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"}
{"level":"info","ts":"2026-08-05T11:33:42.811921Z","caller":"traceutil/trace.go:171","msg":"trace[788090154] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:14850; }","duration":"167.818896ms","start":"2026-08-05T11:33:42.644095Z","end":"2026-08-05T11:33:42.811914Z","steps":["trace[788090154] 'agreement among raft nodes before linearized reading'  (duration: 167.533168ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:33:42.811693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.324475ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-05T11:33:42.811979Z","caller":"traceutil/trace.go:171","msg":"trace[1888600118] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:14850; }","duration":"225.622653ms","start":"2026-08-05T11:33:42.586349Z","end":"2026-08-05T11:33:42.811972Z","steps":["trace[1888600118] 'agreement among raft nodes before linearized reading'  (duration: 225.304845ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:33:53.720771Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12766}
{"level":"info","ts":"2026-08-05T11:33:53.79768Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12766,"took":"74.298877ms","hash":2946224717,"current-db-size-bytes":59686912,"current-db-size":"60 MB","current-db-size-in-use-bytes":29024256,"current-db-size-in-use":"29 MB"}
{"level":"info","ts":"2026-08-05T11:33:53.797774Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2946224717,"revision":12766,"compact-revision":10538}
{"level":"info","ts":"2026-08-05T11:35:08.124879Z","caller":"traceutil/trace.go:171","msg":"trace[1917703424] linearizableReadLoop","detail":"{readStateIndex:16184; appliedIndex:16183; }","duration":"261.691933ms","start":"2026-08-05T11:35:07.863162Z","end":"2026-08-05T11:35:08.124854Z","steps":["trace[1917703424] 'read index received'  (duration: 246.596µs)","trace[1917703424] 'applied index is now lower than readState.Index'  (duration: 261.444327ms)"],"step_count":2}
{"level":"info","ts":"2026-08-05T11:35:08.125025Z","caller":"traceutil/trace.go:171","msg":"trace[2048967495] transaction","detail":"{read_only:false; response_revision:15652; number_of_response:1; }","duration":"261.967971ms","start":"2026-08-05T11:35:07.863046Z","end":"2026-08-05T11:35:08.125014Z","steps":["trace[2048967495] 'process raft request'  (duration: 261.657493ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:35:08.125286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.838243ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5521"}
{"level":"info","ts":"2026-08-05T11:35:08.125367Z","caller":"traceutil/trace.go:171","msg":"trace[2137575327] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:15652; }","duration":"224.950006ms","start":"2026-08-05T11:35:07.900397Z","end":"2026-08-05T11:35:08.125347Z","steps":["trace[2137575327] 'agreement among raft nodes before linearized reading'  (duration: 224.748721ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:35:08.125549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.285012ms","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-05T11:35:08.125599Z","caller":"traceutil/trace.go:171","msg":"trace[819338387] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:15652; }","duration":"152.377304ms","start":"2026-08-05T11:35:07.973211Z","end":"2026-08-05T11:35:08.125588Z","steps":["trace[819338387] 'agreement among raft nodes before linearized reading'  (duration: 152.22888ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:35:08.125768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.098474ms","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-05T11:35:08.125829Z","caller":"traceutil/trace.go:171","msg":"trace[1091353716] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:15652; }","duration":"153.185995ms","start":"2026-08-05T11:35:07.97263Z","end":"2026-08-05T11:35:08.125816Z","steps":["trace[1091353716] 'agreement among raft nodes before linearized reading'  (duration: 153.024311ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:35:08.125815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.647109ms","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-05T11:35:08.125998Z","caller":"traceutil/trace.go:171","msg":"trace[362411087] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:15652; }","duration":"262.867165ms","start":"2026-08-05T11:35:07.863112Z","end":"2026-08-05T11:35:08.125979Z","steps":["trace[362411087] 'agreement among raft nodes before linearized reading'  (duration: 262.626898ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:35:08.271492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.882549ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5521"}
{"level":"info","ts":"2026-08-05T11:35:08.271575Z","caller":"traceutil/trace.go:171","msg":"trace[1964887758] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:15652; }","duration":"143.972712ms","start":"2026-08-05T11:35:08.127581Z","end":"2026-08-05T11:35:08.271554Z","steps":["trace[1964887758] 'range keys from in-memory index tree'  (duration: 143.740425ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:35:08.433503Z","caller":"traceutil/trace.go:171","msg":"trace[269664760] transaction","detail":"{read_only:false; response_revision:15653; number_of_response:1; }","duration":"304.464022ms","start":"2026-08-05T11:35:08.129017Z","end":"2026-08-05T11:35:08.433481Z","steps":["trace[269664760] 'process raft request'  (duration: 304.325488ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:35:08.433794Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T11:35:08.129002Z","time spent":"304.564425ms","remote":"127.0.0.1:46226","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:15643 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-08-05T11:35:08.454196Z","caller":"traceutil/trace.go:171","msg":"trace[723740185] linearizableReadLoop","detail":"{readStateIndex:16186; appliedIndex:16184; }","duration":"242.163064ms","start":"2026-08-05T11:35:08.212003Z","end":"2026-08-05T11:35:08.454166Z","steps":["trace[723740185] 'read index received'  (duration: 221.419162ms)","trace[723740185] 'applied index is now lower than readState.Index'  (duration: 20.742272ms)"],"step_count":2}
{"level":"info","ts":"2026-08-05T11:35:08.454411Z","caller":"traceutil/trace.go:171","msg":"trace[1081722718] transaction","detail":"{read_only:false; response_revision:15654; number_of_response:1; }","duration":"325.309896ms","start":"2026-08-05T11:35:08.129059Z","end":"2026-08-05T11:35:08.454369Z","steps":["trace[1081722718] 'process raft request'  (duration: 324.915376ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:35:08.454524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.83638ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-6zmr2\" ","response":"range_response_count:1 size:22100"}
{"level":"info","ts":"2026-08-05T11:35:08.454613Z","caller":"traceutil/trace.go:171","msg":"trace[1655985435] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-6zmr2; range_end:; response_count:1; response_revision:15654; }","duration":"213.971633ms","start":"2026-08-05T11:35:08.240621Z","end":"2026-08-05T11:35:08.454592Z","steps":["trace[1655985435] 'agreement among raft nodes before linearized reading'  (duration: 213.750598ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:35:08.454757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.48535ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5521"}
{"level":"warn","ts":"2026-08-05T11:35:08.454467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.440071ms","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-05T11:35:08.45485Z","caller":"traceutil/trace.go:171","msg":"trace[1990294772] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:15654; }","duration":"172.609223ms","start":"2026-08-05T11:35:08.282226Z","end":"2026-08-05T11:35:08.454835Z","steps":["trace[1990294772] 'agreement among raft nodes before linearized reading'  (duration: 172.458849ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:35:08.454755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.459139ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:668"}
{"level":"warn","ts":"2026-08-05T11:35:08.454888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.509971ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-08-05T11:35:08.45493Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.528407ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-6zmr2\" ","response":"range_response_count:1 size:22100"}
{"level":"info","ts":"2026-08-05T11:35:08.45488Z","caller":"traceutil/trace.go:171","msg":"trace[610545986] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:15654; }","duration":"242.911824ms","start":"2026-08-05T11:35:08.211954Z","end":"2026-08-05T11:35:08.454866Z","steps":["trace[610545986] 'agreement among raft nodes before linearized reading'  (duration: 242.365659ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:35:08.455031Z","caller":"traceutil/trace.go:171","msg":"trace[385734328] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:15654; }","duration":"172.689385ms","start":"2026-08-05T11:35:08.282306Z","end":"2026-08-05T11:35:08.454995Z","steps":["trace[385734328] 'agreement among raft nodes before linearized reading'  (duration: 172.417028ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:35:08.454905Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T11:35:08.129041Z","time spent":"325.646116ms","remote":"127.0.0.1:46226","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:15644 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-08-05T11:35:08.455027Z","caller":"traceutil/trace.go:171","msg":"trace[1388431138] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:15654; }","duration":"172.714716ms","start":"2026-08-05T11:35:08.282242Z","end":"2026-08-05T11:35:08.454957Z","steps":["trace[1388431138] 'agreement among raft nodes before linearized reading'  (duration: 172.425568ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:35:08.455062Z","caller":"traceutil/trace.go:171","msg":"trace[1456831671] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-6zmr2; range_end:; response_count:1; response_revision:15654; }","duration":"191.706771ms","start":"2026-08-05T11:35:08.263332Z","end":"2026-08-05T11:35:08.455039Z","steps":["trace[1456831671] 'agreement among raft nodes before linearized reading'  (duration: 191.393203ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:35:08.666868Z","caller":"traceutil/trace.go:171","msg":"trace[1747727764] linearizableReadLoop","detail":"{readStateIndex:16187; appliedIndex:16186; }","duration":"204.534673ms","start":"2026-08-05T11:35:08.462302Z","end":"2026-08-05T11:35:08.666837Z","steps":["trace[1747727764] 'read index received'  (duration: 164.260471ms)","trace[1747727764] 'applied index is now lower than readState.Index'  (duration: 40.272782ms)"],"step_count":2}
{"level":"info","ts":"2026-08-05T11:35:08.666966Z","caller":"traceutil/trace.go:171","msg":"trace[1280550782] transaction","detail":"{read_only:false; response_revision:15655; number_of_response:1; }","duration":"205.456938ms","start":"2026-08-05T11:35:08.461479Z","end":"2026-08-05T11:35:08.666936Z","steps":["trace[1280550782] 'process raft request'  (duration: 165.080683ms)","trace[1280550782] 'compare'  (duration: 40.122748ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-05T11:35:08.667565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.246362ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:76 size:737320"}
{"level":"warn","ts":"2026-08-05T11:35:08.667594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.499845ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:76 size:737320"}
{"level":"info","ts":"2026-08-05T11:35:08.667611Z","caller":"traceutil/trace.go:171","msg":"trace[1295848849] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:76; response_revision:15655; }","duration":"205.306213ms","start":"2026-08-05T11:35:08.462293Z","end":"2026-08-05T11:35:08.667599Z","steps":["trace[1295848849] 'agreement among raft nodes before linearized reading'  (duration: 204.671697ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:35:08.667626Z","caller":"traceutil/trace.go:171","msg":"trace[1218119091] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:76; response_revision:15655; }","duration":"203.556777ms","start":"2026-08-05T11:35:08.46406Z","end":"2026-08-05T11:35:08.667617Z","steps":["trace[1218119091] 'agreement among raft nodes before linearized reading'  (duration: 202.943481ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:35:08.668072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.189289ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-05T11:35:08.668102Z","caller":"traceutil/trace.go:171","msg":"trace[1879323695] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:15655; }","duration":"105.263061ms","start":"2026-08-05T11:35:08.56283Z","end":"2026-08-05T11:35:08.668093Z","steps":["trace[1879323695] 'agreement among raft nodes before linearized reading'  (duration: 105.211269ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:35:08.668294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.695168ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/libvirt-libvirt-default-5qjgf\" ","response":"range_response_count:1 size:20643"}
{"level":"info","ts":"2026-08-05T11:35:08.668322Z","caller":"traceutil/trace.go:171","msg":"trace[1025565210] range","detail":"{range_begin:/registry/pods/openstack/libvirt-libvirt-default-5qjgf; range_end:; response_count:1; response_revision:15655; }","duration":"127.752699ms","start":"2026-08-05T11:35:08.540561Z","end":"2026-08-05T11:35:08.668314Z","steps":["trace[1025565210] 'agreement among raft nodes before linearized reading'  (duration: 127.668217ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:35:08.66835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.179372ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.carvel.dev/secretexports/\" range_end:\"/registry/secretgen.carvel.dev/secretexports0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-05T11:35:08.668384Z","caller":"traceutil/trace.go:171","msg":"trace[1733805023] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secretexports/; range_end:/registry/secretgen.carvel.dev/secretexports0; response_count:0; response_revision:15655; }","duration":"157.252854ms","start":"2026-08-05T11:35:08.511121Z","end":"2026-08-05T11:35:08.668374Z","steps":["trace[1733805023] 'agreement among raft nodes before linearized reading'  (duration: 157.199163ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:36:02.292391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.632123ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3415874564932326637 > lease_revoke:<id:2f679fd198155349>","response":"size:28"}
{"level":"info","ts":"2026-08-05T11:38:53.726205Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14935}
{"level":"info","ts":"2026-08-05T11:38:53.818342Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14935,"took":"89.516872ms","hash":3213926657,"current-db-size-bytes":59686912,"current-db-size":"60 MB","current-db-size-in-use-bytes":30588928,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-08-05T11:38:53.818399Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3213926657,"revision":14935,"compact-revision":12766}
{"level":"info","ts":"2026-08-05T11:41:13.60795Z","caller":"traceutil/trace.go:171","msg":"trace[1579116585] transaction","detail":"{read_only:false; response_revision:18322; number_of_response:1; }","duration":"105.526878ms","start":"2026-08-05T11:41:13.502401Z","end":"2026-08-05T11:41:13.607928Z","steps":["trace[1579116585] 'process raft request'  (duration: 105.373224ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:41:20.600276Z","caller":"traceutil/trace.go:171","msg":"trace[1390388682] transaction","detail":"{read_only:false; response_revision:18361; number_of_response:1; }","duration":"232.957238ms","start":"2026-08-05T11:41:20.367291Z","end":"2026-08-05T11:41:20.600248Z","steps":["trace[1390388682] 'process raft request'  (duration: 232.780004ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:41:20.600299Z","caller":"traceutil/trace.go:171","msg":"trace[1609039633] linearizableReadLoop","detail":"{readStateIndex:18984; appliedIndex:18984; }","duration":"231.742167ms","start":"2026-08-05T11:41:20.368514Z","end":"2026-08-05T11:41:20.600256Z","steps":["trace[1609039633] 'read index received'  (duration: 231.722986ms)","trace[1609039633] 'applied index is now lower than readState.Index'  (duration: 16.001µs)"],"step_count":2}
{"level":"warn","ts":"2026-08-05T11:41:20.600718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.173458ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"}
{"level":"info","ts":"2026-08-05T11:41:20.600787Z","caller":"traceutil/trace.go:171","msg":"trace[1070727988] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:18361; }","duration":"232.306161ms","start":"2026-08-05T11:41:20.368463Z","end":"2026-08-05T11:41:20.600769Z","steps":["trace[1070727988] 'agreement among raft nodes before linearized reading'  (duration: 232.025294ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:41:20.645695Z","caller":"traceutil/trace.go:171","msg":"trace[23298830] transaction","detail":"{read_only:false; response_revision:18363; number_of_response:1; }","duration":"133.260206ms","start":"2026-08-05T11:41:20.512403Z","end":"2026-08-05T11:41:20.645663Z","steps":["trace[23298830] 'process raft request'  (duration: 133.143363ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:41:20.645708Z","caller":"traceutil/trace.go:171","msg":"trace[339610869] transaction","detail":"{read_only:false; response_revision:18362; number_of_response:1; }","duration":"139.4113ms","start":"2026-08-05T11:41:20.506266Z","end":"2026-08-05T11:41:20.645677Z","steps":["trace[339610869] 'process raft request'  (duration: 139.138602ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:41:20.646044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.007847ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"}
{"level":"info","ts":"2026-08-05T11:41:20.646099Z","caller":"traceutil/trace.go:171","msg":"trace[1834387445] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:18364; }","duration":"116.13584ms","start":"2026-08-05T11:41:20.529946Z","end":"2026-08-05T11:41:20.646082Z","steps":["trace[1834387445] 'agreement among raft nodes before linearized reading'  (duration: 115.938545ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:41:20.646105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.738027ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-08-05T11:41:20.646213Z","caller":"traceutil/trace.go:171","msg":"trace[1003056805] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:18364; }","duration":"266.914502ms","start":"2026-08-05T11:41:20.379272Z","end":"2026-08-05T11:41:20.646186Z","steps":["trace[1003056805] 'agreement among raft nodes before linearized reading'  (duration: 266.584883ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:41:20.64628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.131444ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclusters/openstack/ceph\" ","response":"range_response_count:1 size:7697"}
{"level":"info","ts":"2026-08-05T11:41:20.646567Z","caller":"traceutil/trace.go:171","msg":"trace[968483708] range","detail":"{range_begin:/registry/ceph.rook.io/cephclusters/openstack/ceph; range_end:; response_count:1; response_revision:18364; }","duration":"121.3841ms","start":"2026-08-05T11:41:20.525077Z","end":"2026-08-05T11:41:20.646462Z","steps":["trace[968483708] 'agreement among raft nodes before linearized reading'  (duration: 121.00515ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:41:21.069213Z","caller":"traceutil/trace.go:171","msg":"trace[242232469] linearizableReadLoop","detail":"{readStateIndex:18990; appliedIndex:18989; }","duration":"313.691696ms","start":"2026-08-05T11:41:20.755491Z","end":"2026-08-05T11:41:21.069183Z","steps":["trace[242232469] 'read index received'  (duration: 313.47422ms)","trace[242232469] 'applied index is now lower than readState.Index'  (duration: 215.986µs)"],"step_count":2}
{"level":"info","ts":"2026-08-05T11:41:21.069305Z","caller":"traceutil/trace.go:171","msg":"trace[1548069597] transaction","detail":"{read_only:false; response_revision:18367; number_of_response:1; }","duration":"322.322476ms","start":"2026-08-05T11:41:20.746945Z","end":"2026-08-05T11:41:21.069267Z","steps":["trace[1548069597] 'process raft request'  (duration: 322.014038ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:41:21.069467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.951314ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:1854"}
{"level":"warn","ts":"2026-08-05T11:41:21.069471Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T11:41:20.746918Z","time spent":"322.461439ms","remote":"127.0.0.1:46156","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":20863,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/pods/openstack/libvirt-libvirt-default-5qjgf\" mod_revision:18306 > success:<request_put:<key:\"/registry/pods/openstack/libvirt-libvirt-default-5qjgf\" value_size:20799 >> failure:<request_range:<key:\"/registry/pods/openstack/libvirt-libvirt-default-5qjgf\" > >"}
{"level":"info","ts":"2026-08-05T11:41:21.069517Z","caller":"traceutil/trace.go:171","msg":"trace[1859775168] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:18367; }","duration":"314.017895ms","start":"2026-08-05T11:41:20.755484Z","end":"2026-08-05T11:41:21.069501Z","steps":["trace[1859775168] 'agreement among raft nodes before linearized reading'  (duration: 313.853061ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:41:21.069556Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T11:41:20.755434Z","time spent":"314.113258ms","remote":"127.0.0.1:46120","response type":"/etcdserverpb.KV/Range","request count":0,"request size":73,"response count":1,"response size":1877,"request content":"key:\"/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0\" "}
{"level":"warn","ts":"2026-08-05T11:41:21.069638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.516828ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-05T11:41:21.069686Z","caller":"traceutil/trace.go:171","msg":"trace[1398797370] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:18367; }","duration":"261.619031ms","start":"2026-08-05T11:41:20.808053Z","end":"2026-08-05T11:41:21.069672Z","steps":["trace[1398797370] 'agreement among raft nodes before linearized reading'  (duration: 261.544589ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:41:21.455143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.052932ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"}
{"level":"info","ts":"2026-08-05T11:41:21.45524Z","caller":"traceutil/trace.go:171","msg":"trace[1130550142] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:18367; }","duration":"103.185515ms","start":"2026-08-05T11:41:21.352032Z","end":"2026-08-05T11:41:21.455217Z","steps":["trace[1130550142] 'range keys from in-memory index tree'  (duration: 102.946969ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:41:21.747854Z","caller":"traceutil/trace.go:171","msg":"trace[839580605] transaction","detail":"{read_only:false; response_revision:18368; number_of_response:1; }","duration":"288.434625ms","start":"2026-08-05T11:41:21.459387Z","end":"2026-08-05T11:41:21.747821Z","steps":["trace[839580605] 'process raft request'  (duration: 288.24771ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:41:21.835245Z","caller":"traceutil/trace.go:171","msg":"trace[1558080066] transaction","detail":"{read_only:false; response_revision:18370; number_of_response:1; }","duration":"341.006224ms","start":"2026-08-05T11:41:21.494213Z","end":"2026-08-05T11:41:21.83522Z","steps":["trace[1558080066] 'process raft request'  (duration: 340.905171ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:41:21.835276Z","caller":"traceutil/trace.go:171","msg":"trace[719379975] transaction","detail":"{read_only:false; response_revision:18369; number_of_response:1; }","duration":"375.43294ms","start":"2026-08-05T11:41:21.459803Z","end":"2026-08-05T11:41:21.835236Z","steps":["trace[719379975] 'process raft request'  (duration: 375.106992ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:41:21.835392Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T11:41:21.494192Z","time spent":"341.125488ms","remote":"127.0.0.1:53000","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7680,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/ceph.rook.io/cephclusters/openstack/ceph\" mod_revision:17937 > success:<request_put:<key:\"/registry/ceph.rook.io/cephclusters/openstack/ceph\" value_size:7622 >> failure:<request_range:<key:\"/registry/ceph.rook.io/cephclusters/openstack/ceph\" > >"}
{"level":"info","ts":"2026-08-05T11:41:21.83547Z","caller":"traceutil/trace.go:171","msg":"trace[3001853] transaction","detail":"{read_only:false; response_revision:18371; number_of_response:1; }","duration":"193.16452ms","start":"2026-08-05T11:41:21.64229Z","end":"2026-08-05T11:41:21.835455Z","steps":["trace[3001853] 'process raft request'  (duration: 192.891373ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:41:21.835466Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T11:41:21.459774Z","time spent":"375.581884ms","remote":"127.0.0.1:46226","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:18355 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-08-05T11:41:21.835601Z","caller":"traceutil/trace.go:171","msg":"trace[826778095] linearizableReadLoop","detail":"{readStateIndex:18992; appliedIndex:18990; }","duration":"367.91338ms","start":"2026-08-05T11:41:21.467643Z","end":"2026-08-05T11:41:21.835556Z","steps":["trace[826778095] 'read index received'  (duration: 279.98779ms)","trace[826778095] 'applied index is now lower than readState.Index'  (duration: 87.9201ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-05T11:41:21.835831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.678832ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-05T11:41:21.835873Z","caller":"traceutil/trace.go:171","msg":"trace[299050371] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:18371; }","duration":"273.767485ms","start":"2026-08-05T11:41:21.562094Z","end":"2026-08-05T11:41:21.835862Z","steps":["trace[299050371] 'agreement among raft nodes before linearized reading'  (duration: 273.658542ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:41:21.836401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.753982ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:94 size:946644"}
{"level":"info","ts":"2026-08-05T11:41:21.836457Z","caller":"traceutil/trace.go:171","msg":"trace[2122142652] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:94; response_revision:18371; }","duration":"368.813245ms","start":"2026-08-05T11:41:21.467633Z","end":"2026-08-05T11:41:21.836447Z","steps":["trace[2122142652] 'agreement among raft nodes before linearized reading'  (duration: 368.033514ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:41:21.836484Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T11:41:21.467618Z","time spent":"368.857395ms","remote":"127.0.0.1:46156","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":94,"response size":946667,"request content":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" "}
{"level":"info","ts":"2026-08-05T11:41:29.511824Z","caller":"traceutil/trace.go:171","msg":"trace[1003170206] transaction","detail":"{read_only:false; response_revision:18486; number_of_response:1; }","duration":"109.043491ms","start":"2026-08-05T11:41:29.40272Z","end":"2026-08-05T11:41:29.511763Z","steps":["trace[1003170206] 'process raft request'  (duration: 108.723663ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:41:34.353074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.480143ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3415874564932336363 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/endpointslices/openstack/rabbitmq-heat-nodes-sc72x\" mod_revision:18407 > success:<request_put:<key:\"/registry/endpointslices/openstack/rabbitmq-heat-nodes-sc72x\" value_size:1406 >> failure:<request_range:<key:\"/registry/endpointslices/openstack/rabbitmq-heat-nodes-sc72x\" > >>","response":"size:18"}
{"level":"info","ts":"2026-08-05T11:41:34.353232Z","caller":"traceutil/trace.go:171","msg":"trace[269694432] transaction","detail":"{read_only:false; response_revision:18584; number_of_response:1; }","duration":"305.973212ms","start":"2026-08-05T11:41:34.047235Z","end":"2026-08-05T11:41:34.353208Z","steps":["trace[269694432] 'process raft request'  (duration: 25.243012ms)","trace[269694432] 'compare'  (duration: 280.174496ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-05T11:41:34.353304Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T11:41:34.047206Z","time spent":"306.064724ms","remote":"127.0.0.1:46228","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1474,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/endpointslices/openstack/rabbitmq-heat-nodes-sc72x\" mod_revision:18407 > success:<request_put:<key:\"/registry/endpointslices/openstack/rabbitmq-heat-nodes-sc72x\" value_size:1406 >> failure:<request_range:<key:\"/registry/endpointslices/openstack/rabbitmq-heat-nodes-sc72x\" > >"}
{"level":"info","ts":"2026-08-05T11:41:34.370984Z","caller":"traceutil/trace.go:171","msg":"trace[1787225662] linearizableReadLoop","detail":"{readStateIndex:19220; appliedIndex:19216; }","duration":"311.668553ms","start":"2026-08-05T11:41:34.059238Z","end":"2026-08-05T11:41:34.370907Z","steps":["trace[1787225662] 'read index received'  (duration: 13.259213ms)","trace[1787225662] 'applied index is now lower than readState.Index'  (duration: 298.40785ms)"],"step_count":2}
{"level":"info","ts":"2026-08-05T11:41:34.371032Z","caller":"traceutil/trace.go:171","msg":"trace[1882273487] transaction","detail":"{read_only:false; response_revision:18587; number_of_response:1; }","duration":"323.298353ms","start":"2026-08-05T11:41:34.047697Z","end":"2026-08-05T11:41:34.370996Z","steps":["trace[1882273487] 'process raft request'  (duration: 323.067737ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:41:34.371078Z","caller":"traceutil/trace.go:171","msg":"trace[689547280] transaction","detail":"{read_only:false; response_revision:18586; number_of_response:1; }","duration":"323.361625ms","start":"2026-08-05T11:41:34.047682Z","end":"2026-08-05T11:41:34.371043Z","steps":["trace[689547280] 'process raft request'  (duration: 322.7836ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:41:34.371193Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T11:41:34.04767Z","time spent":"323.467637ms","remote":"127.0.0.1:46228","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1401,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/endpointslices/openstack/rabbitmq-heat-j468w\" mod_revision:18410 > success:<request_put:<key:\"/registry/endpointslices/openstack/rabbitmq-heat-j468w\" value_size:1339 >> failure:<request_range:<key:\"/registry/endpointslices/openstack/rabbitmq-heat-j468w\" > >"}
{"level":"warn","ts":"2026-08-05T11:41:34.371237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.974012ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-heat-server-0\" ","response":"range_response_count:1 size:1852"}
{"level":"warn","ts":"2026-08-05T11:41:34.371229Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T11:41:34.047688Z","time spent":"323.414286ms","remote":"127.0.0.1:46134","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":877,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/services/endpoints/openstack/rabbitmq-heat\" mod_revision:18412 > success:<request_put:<key:\"/registry/services/endpoints/openstack/rabbitmq-heat\" value_size:817 >> failure:<request_range:<key:\"/registry/services/endpoints/openstack/rabbitmq-heat\" > >"}
{"level":"info","ts":"2026-08-05T11:41:34.371294Z","caller":"traceutil/trace.go:171","msg":"trace[662383953] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-heat-server-0; range_end:; response_count:1; response_revision:18587; }","duration":"312.044774ms","start":"2026-08-05T11:41:34.059231Z","end":"2026-08-05T11:41:34.371275Z","steps":["trace[662383953] 'agreement among raft nodes before linearized reading'  (duration: 311.852429ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:41:34.371337Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T11:41:34.05919Z","time spent":"312.137086ms","remote":"127.0.0.1:46120","response type":"/etcdserverpb.KV/Range","request count":0,"request size":79,"response count":1,"response size":1875,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-heat-server-0\" "}
{"level":"info","ts":"2026-08-05T11:41:34.371943Z","caller":"traceutil/trace.go:171","msg":"trace[1118249241] transaction","detail":"{read_only:false; response_revision:18585; number_of_response:1; }","duration":"323.034096ms","start":"2026-08-05T11:41:34.047594Z","end":"2026-08-05T11:41:34.370628Z","steps":["trace[1118249241] 'process raft request'  (duration: 322.721348ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:41:34.37206Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T11:41:34.047568Z","time spent":"324.424153ms","remote":"127.0.0.1:46134","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":931,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/services/endpoints/openstack/rabbitmq-heat-nodes\" mod_revision:18405 > success:<request_put:<key:\"/registry/services/endpoints/openstack/rabbitmq-heat-nodes\" value_size:865 >> failure:<request_range:<key:\"/registry/services/endpoints/openstack/rabbitmq-heat-nodes\" > >"}
{"level":"info","ts":"2026-08-05T11:41:34.401752Z","caller":"traceutil/trace.go:171","msg":"trace[1242994592] transaction","detail":"{read_only:false; response_revision:18588; number_of_response:1; }","duration":"147.741131ms","start":"2026-08-05T11:41:34.253972Z","end":"2026-08-05T11:41:34.401713Z","steps":["trace[1242994592] 'process raft request'  (duration: 147.550706ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:42:38.636837Z","caller":"traceutil/trace.go:171","msg":"trace[994924332] transaction","detail":"{read_only:false; response_revision:19190; number_of_response:1; }","duration":"126.25216ms","start":"2026-08-05T11:42:38.510529Z","end":"2026-08-05T11:42:38.636781Z","steps":["trace[994924332] 'process raft request'  (duration: 125.989503ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:42:39.581709Z","caller":"traceutil/trace.go:171","msg":"trace[1796921728] transaction","detail":"{read_only:false; response_revision:19201; number_of_response:1; }","duration":"113.587792ms","start":"2026-08-05T11:42:39.468091Z","end":"2026-08-05T11:42:39.581678Z","steps":["trace[1796921728] 'process raft request'  (duration: 113.319775ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:42:48.580699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.687825ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3415874564932338409 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" mod_revision:19209 > success:<request_put:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" value_size:415 >> failure:<request_range:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" > >>","response":"size:18"}
{"level":"info","ts":"2026-08-05T11:42:48.580847Z","caller":"traceutil/trace.go:171","msg":"trace[59483280] transaction","detail":"{read_only:false; response_revision:19264; number_of_response:1; }","duration":"496.529273ms","start":"2026-08-05T11:42:48.08429Z","end":"2026-08-05T11:42:48.580819Z","steps":["trace[59483280] 'process raft request'  (duration: 373.620492ms)","trace[59483280] 'compare'  (duration: 122.292594ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-05T11:42:48.580954Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T11:42:48.084266Z","time spent":"496.638735ms","remote":"127.0.0.1:46226","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" mod_revision:19209 > success:<request_put:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" value_size:415 >> failure:<request_range:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" > >"}
{"level":"info","ts":"2026-08-05T11:42:48.654244Z","caller":"traceutil/trace.go:171","msg":"trace[1888506842] linearizableReadLoop","detail":"{readStateIndex:19915; appliedIndex:19913; }","duration":"370.197321ms","start":"2026-08-05T11:42:48.284007Z","end":"2026-08-05T11:42:48.654205Z","steps":["trace[1888506842] 'read index received'  (duration: 174.077292ms)","trace[1888506842] 'applied index is now lower than readState.Index'  (duration: 196.118809ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-05T11:42:48.654584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.10644ms","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-05T11:42:48.654623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"370.50338ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-6zmr2\" ","response":"range_response_count:1 size:23298"}
{"level":"warn","ts":"2026-08-05T11:42:48.654685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.300805ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"}
{"level":"info","ts":"2026-08-05T11:42:48.654723Z","caller":"traceutil/trace.go:171","msg":"trace[2095565342] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-6zmr2; range_end:; response_count:1; response_revision:19265; }","duration":"370.735665ms","start":"2026-08-05T11:42:48.283967Z","end":"2026-08-05T11:42:48.654702Z","steps":["trace[2095565342] 'agreement among raft nodes before linearized reading'  (duration: 370.405206ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:42:48.654751Z","caller":"traceutil/trace.go:171","msg":"trace[128034830] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:19265; }","duration":"278.365847ms","start":"2026-08-05T11:42:48.376368Z","end":"2026-08-05T11:42:48.654734Z","steps":["trace[128034830] 'agreement among raft nodes before linearized reading'  (duration: 278.212673ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:42:48.654812Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T11:42:48.28395Z","time spent":"370.845768ms","remote":"127.0.0.1:46156","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":23321,"request content":"key:\"/registry/pods/openstack/nova-compute-default-6zmr2\" "}
{"level":"info","ts":"2026-08-05T11:42:48.657299Z","caller":"traceutil/trace.go:171","msg":"trace[1282926514] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:19265; }","duration":"340.222713ms","start":"2026-08-05T11:42:48.314407Z","end":"2026-08-05T11:42:48.65463Z","steps":["trace[1282926514] 'agreement among raft nodes before linearized reading'  (duration: 340.014307ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:42:48.657339Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T11:42:48.314375Z","time spent":"342.953086ms","remote":"127.0.0.1:46226","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":"info","ts":"2026-08-05T11:42:48.657673Z","caller":"traceutil/trace.go:171","msg":"trace[477995843] transaction","detail":"{read_only:false; response_revision:19265; number_of_response:1; }","duration":"379.869808ms","start":"2026-08-05T11:42:48.274467Z","end":"2026-08-05T11:42:48.654336Z","steps":["trace[477995843] 'process raft request'  (duration: 379.58511ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:42:48.659338Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T11:42:48.274438Z","time spent":"384.81976ms","remote":"127.0.0.1:46226","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:19251 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"info","ts":"2026-08-05T11:42:48.795643Z","caller":"traceutil/trace.go:171","msg":"trace[1445788910] transaction","detail":"{read_only:false; response_revision:19266; number_of_response:1; }","duration":"132.982139ms","start":"2026-08-05T11:42:48.662635Z","end":"2026-08-05T11:42:48.795617Z","steps":["trace[1445788910] 'process raft request'  (duration: 132.792743ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:42:48.833341Z","caller":"traceutil/trace.go:171","msg":"trace[834819424] transaction","detail":"{read_only:false; response_revision:19267; number_of_response:1; }","duration":"170.569259ms","start":"2026-08-05T11:42:48.662745Z","end":"2026-08-05T11:42:48.833315Z","steps":["trace[834819424] 'process raft request'  (duration: 170.335082ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:42:48.833626Z","caller":"traceutil/trace.go:171","msg":"trace[1530678917] transaction","detail":"{read_only:false; response_revision:19268; number_of_response:1; }","duration":"160.45591ms","start":"2026-08-05T11:42:48.673141Z","end":"2026-08-05T11:42:48.833596Z","steps":["trace[1530678917] 'process raft request'  (duration: 160.08933ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:42:48.833858Z","caller":"traceutil/trace.go:171","msg":"trace[1617171983] transaction","detail":"{read_only:false; response_revision:19269; number_of_response:1; }","duration":"150.484204ms","start":"2026-08-05T11:42:48.683165Z","end":"2026-08-05T11:42:48.833649Z","steps":["trace[1617171983] 'process raft request'  (duration: 150.307ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:42:59.420213Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"39582465ceaa2f67","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-08-05T11:42:59.420344Z","caller":"traceutil/trace.go:171","msg":"trace[183874599] transaction","detail":"{read_only:false; response_revision:19350; number_of_response:1; }","duration":"143.904996ms","start":"2026-08-05T11:42:59.276403Z","end":"2026-08-05T11:42:59.420308Z","steps":["trace[183874599] 'process raft request'  (duration: 142.666173ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:42:59.420771Z","caller":"traceutil/trace.go:171","msg":"trace[1340258511] linearizableReadLoop","detail":"{readStateIndex:20002; appliedIndex:20001; }","duration":"137.222859ms","start":"2026-08-05T11:42:59.283239Z","end":"2026-08-05T11:42:59.420462Z","steps":["trace[1340258511] 'read index received'  (duration: 135.76373ms)","trace[1340258511] 'applied index is now lower than readState.Index'  (duration: 1.457519ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-05T11:42:59.506448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.386424ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusterrestores/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterrestores0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-05T11:42:59.506514Z","caller":"traceutil/trace.go:171","msg":"trace[615621940] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusterrestores/; range_end:/registry/pxc.percona.com/perconaxtradbclusterrestores0; response_count:0; response_revision:19350; }","duration":"201.489197ms","start":"2026-08-05T11:42:59.305009Z","end":"2026-08-05T11:42:59.506498Z","steps":["trace[615621940] 'agreement among raft nodes before linearized reading'  (duration: 116.145898ms)","trace[615621940] 'count revisions from in-memory index tree'  (duration: 85.248087ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-05T11:42:59.506558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.183778ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/heat-ks-user\" ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-08-05T11:42:59.506631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.691125ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/heat-bootstrap\" ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-08-05T11:42:59.506696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.946852ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/heat-ks-endpoints\" ","response":"range_response_count:1 size:21452"}
{"level":"warn","ts":"2026-08-05T11:42:59.50669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.627297ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"}
{"level":"info","ts":"2026-08-05T11:42:59.506725Z","caller":"traceutil/trace.go:171","msg":"trace[1826714399] range","detail":"{range_begin:/registry/jobs/openstack/heat-bootstrap; range_end:; response_count:0; response_revision:19350; }","duration":"171.807238ms","start":"2026-08-05T11:42:59.334893Z","end":"2026-08-05T11:42:59.5067Z","steps":["trace[1826714399] 'agreement among raft nodes before linearized reading'  (duration: 86.233312ms)","trace[1826714399] 'range keys from in-memory index tree'  (duration: 85.459733ms)"],"step_count":2}
{"level":"info","ts":"2026-08-05T11:42:59.50674Z","caller":"traceutil/trace.go:171","msg":"trace[1127968780] range","detail":"{range_begin:/registry/jobs/openstack/heat-ks-endpoints; range_end:; response_count:1; response_revision:19350; }","duration":"169.026074ms","start":"2026-08-05T11:42:59.337704Z","end":"2026-08-05T11:42:59.50673Z","steps":["trace[1127968780] 'agreement among raft nodes before linearized reading'  (duration: 83.412488ms)","trace[1127968780] 'range keys from in-memory index tree'  (duration: 85.34986ms)"],"step_count":2}
{"level":"info","ts":"2026-08-05T11:42:59.506755Z","caller":"traceutil/trace.go:171","msg":"trace[1692586757] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:19350; }","duration":"211.74752ms","start":"2026-08-05T11:42:59.294989Z","end":"2026-08-05T11:42:59.506736Z","steps":["trace[1692586757] 'agreement among raft nodes before linearized reading'  (duration: 126.105803ms)","trace[1692586757] 'range keys from in-memory index tree'  (duration: 85.484913ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-05T11:42:59.506724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.453261ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"}
{"level":"info","ts":"2026-08-05T11:42:59.506821Z","caller":"traceutil/trace.go:171","msg":"trace[1793619062] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:19350; }","duration":"223.593144ms","start":"2026-08-05T11:42:59.283206Z","end":"2026-08-05T11:42:59.506799Z","steps":["trace[1793619062] 'agreement among raft nodes before linearized reading'  (duration: 137.395862ms)","trace[1793619062] 'range keys from in-memory index tree'  (duration: 85.944835ms)"],"step_count":2}
{"level":"info","ts":"2026-08-05T11:42:59.506643Z","caller":"traceutil/trace.go:171","msg":"trace[1240083628] range","detail":"{range_begin:/registry/jobs/openstack/heat-ks-user; range_end:; response_count:0; response_revision:19350; }","duration":"172.300542ms","start":"2026-08-05T11:42:59.334321Z","end":"2026-08-05T11:42:59.506621Z","steps":["trace[1240083628] 'agreement among raft nodes before linearized reading'  (duration: 86.825519ms)","trace[1240083628] 'range keys from in-memory index tree'  (duration: 85.37229ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-05T11:42:59.506523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.636863ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/heat-domain-ks-user\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-05T11:42:59.507253Z","caller":"traceutil/trace.go:171","msg":"trace[1243895861] range","detail":"{range_begin:/registry/jobs/openstack/heat-domain-ks-user; range_end:; response_count:0; response_revision:19350; }","duration":"172.378364ms","start":"2026-08-05T11:42:59.334849Z","end":"2026-08-05T11:42:59.507227Z","steps":["trace[1243895861] 'agreement among raft nodes before linearized reading'  (duration: 86.287185ms)","trace[1243895861] 'range keys from in-memory index tree'  (duration: 85.350039ms)"],"step_count":2}
{"level":"info","ts":"2026-08-05T11:42:59.662638Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002}
{"level":"info","ts":"2026-08-05T11:42:59.662939Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002}
{"level":"warn","ts":"2026-08-05T11:42:59.684719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.857632ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.carvel.dev/secretexports/\" range_end:\"/registry/secretgen.carvel.dev/secretexports0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-05T11:42:59.684843Z","caller":"traceutil/trace.go:171","msg":"trace[393165693] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secretexports/; range_end:/registry/secretgen.carvel.dev/secretexports0; response_count:0; response_revision:19355; }","duration":"101.061497ms","start":"2026-08-05T11:42:59.583751Z","end":"2026-08-05T11:42:59.684813Z","steps":["trace[393165693] 'agreement among raft nodes before linearized reading'  (duration: 45.087309ms)","trace[393165693] 'count revisions from in-memory index tree'  (duration: 55.768663ms)"],"step_count":2}
{"level":"info","ts":"2026-08-05T11:43:22.318253Z","caller":"traceutil/trace.go:171","msg":"trace[1654641114] transaction","detail":"{read_only:false; response_revision:19518; number_of_response:1; }","duration":"139.005246ms","start":"2026-08-05T11:43:22.179226Z","end":"2026-08-05T11:43:22.318232Z","steps":["trace[1654641114] 'process raft request'  (duration: 138.867462ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:43:25.363502Z","caller":"traceutil/trace.go:171","msg":"trace[240866206] linearizableReadLoop","detail":"{readStateIndex:20192; appliedIndex:20191; }","duration":"110.443866ms","start":"2026-08-05T11:43:25.253005Z","end":"2026-08-05T11:43:25.363449Z","steps":["trace[240866206] 'read index received'  (duration: 80.198562ms)","trace[240866206] 'applied index is now lower than readState.Index'  (duration: 30.243834ms)"],"step_count":2}
{"level":"info","ts":"2026-08-05T11:43:25.363517Z","caller":"traceutil/trace.go:171","msg":"trace[717681009] transaction","detail":"{read_only:false; response_revision:19535; number_of_response:1; }","duration":"112.121491ms","start":"2026-08-05T11:43:25.25136Z","end":"2026-08-05T11:43:25.363482Z","steps":["trace[717681009] 'process raft request'  (duration: 81.894177ms)","trace[717681009] 'compare'  (duration: 29.909476ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-05T11:43:25.36376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.719404ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"}
{"level":"info","ts":"2026-08-05T11:43:25.363809Z","caller":"traceutil/trace.go:171","msg":"trace[404909396] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:19535; }","duration":"110.835177ms","start":"2026-08-05T11:43:25.252963Z","end":"2026-08-05T11:43:25.363798Z","steps":["trace[404909396] 'agreement among raft nodes before linearized reading'  (duration: 110.641242ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:43:37.895956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.779572ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/heat-domain-ks-user\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-05T11:43:37.896061Z","caller":"traceutil/trace.go:171","msg":"trace[650660531] range","detail":"{range_begin:/registry/jobs/openstack/heat-domain-ks-user; range_end:; response_count:0; response_revision:19600; }","duration":"108.897856ms","start":"2026-08-05T11:43:37.787146Z","end":"2026-08-05T11:43:37.896044Z","steps":["trace[650660531] 'range keys from in-memory index tree'  (duration: 108.71074ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:43:53.733149Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17382}
{"level":"info","ts":"2026-08-05T11:43:53.850708Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17382,"took":"113.008844ms","hash":1570363935,"current-db-size-bytes":59686912,"current-db-size":"60 MB","current-db-size-in-use-bytes":34164736,"current-db-size-in-use":"34 MB"}
{"level":"info","ts":"2026-08-05T11:43:53.850766Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1570363935,"revision":17382,"compact-revision":14935}
{"level":"info","ts":"2026-08-05T11:43:57.550124Z","caller":"traceutil/trace.go:171","msg":"trace[1387068122] transaction","detail":"{read_only:false; response_revision:19699; number_of_response:1; }","duration":"103.744309ms","start":"2026-08-05T11:43:57.446353Z","end":"2026-08-05T11:43:57.550097Z","steps":["trace[1387068122] 'process raft request'  (duration: 36.789609ms)","trace[1387068122] 'compare'  (duration: 66.626631ms)"],"step_count":2}
{"level":"info","ts":"2026-08-05T11:44:12.330381Z","caller":"traceutil/trace.go:171","msg":"trace[652821269] transaction","detail":"{read_only:false; response_revision:19813; number_of_response:1; }","duration":"115.061ms","start":"2026-08-05T11:44:12.215276Z","end":"2026-08-05T11:44:12.330337Z","steps":["trace[652821269] 'process raft request'  (duration: 114.770412ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:44:17.804171Z","caller":"traceutil/trace.go:171","msg":"trace[1504379180] transaction","detail":"{read_only:false; response_revision:19844; number_of_response:1; }","duration":"116.872687ms","start":"2026-08-05T11:44:17.687228Z","end":"2026-08-05T11:44:17.804101Z","steps":["trace[1504379180] 'process raft request'  (duration: 116.302822ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:44:17.816926Z","caller":"traceutil/trace.go:171","msg":"trace[1245696134] transaction","detail":"{read_only:false; response_revision:19845; number_of_response:1; }","duration":"114.038352ms","start":"2026-08-05T11:44:17.702871Z","end":"2026-08-05T11:44:17.816909Z","steps":["trace[1245696134] 'process raft request'  (duration: 113.777175ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:44:17.817078Z","caller":"traceutil/trace.go:171","msg":"trace[1387282469] transaction","detail":"{read_only:false; response_revision:19846; number_of_response:1; }","duration":"110.522609ms","start":"2026-08-05T11:44:17.706548Z","end":"2026-08-05T11:44:17.817071Z","steps":["trace[1387282469] 'process raft request'  (duration: 110.18577ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:44:17.817124Z","caller":"traceutil/trace.go:171","msg":"trace[215764789] transaction","detail":"{read_only:false; response_revision:19847; number_of_response:1; }","duration":"110.540339ms","start":"2026-08-05T11:44:17.706579Z","end":"2026-08-05T11:44:17.817119Z","steps":["trace[215764789] 'process raft request'  (duration: 110.174349ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:44:56.177964Z","caller":"traceutil/trace.go:171","msg":"trace[178832646] transaction","detail":"{read_only:false; response_revision:20079; number_of_response:1; }","duration":"140.758753ms","start":"2026-08-05T11:44:56.037174Z","end":"2026-08-05T11:44:56.177932Z","steps":["trace[178832646] 'process raft request'  (duration: 140.181147ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:47:34.112074Z","caller":"traceutil/trace.go:171","msg":"trace[133043098] transaction","detail":"{read_only:false; response_revision:21189; number_of_response:1; }","duration":"140.07238ms","start":"2026-08-05T11:47:33.971977Z","end":"2026-08-05T11:47:34.11205Z","steps":["trace[133043098] 'process raft request'  (duration: 139.921816ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:47:34.431961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.984597ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3415874564932343828 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:21180 > 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-05T11:47:34.432043Z","caller":"traceutil/trace.go:171","msg":"trace[1591539395] transaction","detail":"{read_only:false; response_revision:21190; number_of_response:1; }","duration":"382.986762ms","start":"2026-08-05T11:47:34.049043Z","end":"2026-08-05T11:47:34.43203Z","steps":["trace[1591539395] 'process raft request'  (duration: 255.871522ms)","trace[1591539395] 'compare'  (duration: 126.769271ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-05T11:47:34.432076Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T11:47:34.049016Z","time spent":"383.044444ms","remote":"127.0.0.1:46226","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:21180 > 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-05T11:47:34.763814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.052588ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3415874564932343829 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:21138 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >>","response":"size:18"}
{"level":"info","ts":"2026-08-05T11:47:34.764094Z","caller":"traceutil/trace.go:171","msg":"trace[562006903] linearizableReadLoop","detail":"{readStateIndex:21911; appliedIndex:21909; }","duration":"128.576718ms","start":"2026-08-05T11:47:34.635495Z","end":"2026-08-05T11:47:34.764071Z","steps":["trace[562006903] 'read index received'  (duration: 108.533361ms)","trace[562006903] 'applied index is now lower than readState.Index'  (duration: 20.041787ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-05T11:47:34.764385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.886677ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"}
{"level":"info","ts":"2026-08-05T11:47:34.764484Z","caller":"traceutil/trace.go:171","msg":"trace[1952780580] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:21192; }","duration":"129.016049ms","start":"2026-08-05T11:47:34.63545Z","end":"2026-08-05T11:47:34.764466Z","steps":["trace[1952780580] 'agreement among raft nodes before linearized reading'  (duration: 128.704261ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:47:34.764575Z","caller":"traceutil/trace.go:171","msg":"trace[517201784] transaction","detail":"{read_only:false; response_revision:21191; number_of_response:1; }","duration":"300.215878ms","start":"2026-08-05T11:47:34.464314Z","end":"2026-08-05T11:47:34.764529Z","steps":["trace[517201784] 'process raft request'  (duration: 148.343758ms)","trace[517201784] 'compare'  (duration: 150.660448ms)"],"step_count":2}
{"level":"info","ts":"2026-08-05T11:47:34.764591Z","caller":"traceutil/trace.go:171","msg":"trace[1313215256] transaction","detail":"{read_only:false; response_revision:21192; number_of_response:1; }","duration":"137.491662ms","start":"2026-08-05T11:47:34.627057Z","end":"2026-08-05T11:47:34.764549Z","steps":["trace[1313215256] 'process raft request'  (duration: 136.898637ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:47:34.764744Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T11:47:34.464288Z","time spent":"300.369291ms","remote":"127.0.0.1:46226","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:21138 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"info","ts":"2026-08-05T11:47:35.067319Z","caller":"traceutil/trace.go:171","msg":"trace[669140755] transaction","detail":"{read_only:false; response_revision:21193; number_of_response:1; }","duration":"299.059577ms","start":"2026-08-05T11:47:34.768233Z","end":"2026-08-05T11:47:35.067292Z","steps":["trace[669140755] 'process raft request'  (duration: 298.894933ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:47:35.329231Z","caller":"traceutil/trace.go:171","msg":"trace[1387301550] transaction","detail":"{read_only:false; response_revision:21194; number_of_response:1; }","duration":"560.6809ms","start":"2026-08-05T11:47:34.768521Z","end":"2026-08-05T11:47:35.329202Z","steps":["trace[1387301550] 'process raft request'  (duration: 484.043627ms)","trace[1387301550] 'compare'  (duration: 76.399657ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-05T11:47:35.329388Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T11:47:34.768506Z","time spent":"560.807214ms","remote":"127.0.0.1:46226","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:21183 > 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-05T11:47:35.329686Z","caller":"traceutil/trace.go:171","msg":"trace[1652957748] transaction","detail":"{read_only:false; response_revision:21195; number_of_response:1; }","duration":"478.535242ms","start":"2026-08-05T11:47:34.85111Z","end":"2026-08-05T11:47:35.329645Z","steps":["trace[1652957748] 'process raft request'  (duration: 478.048259ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:47:35.329933Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T11:47:34.851083Z","time spent":"478.681136ms","remote":"127.0.0.1:46226","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:21184 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:465 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-08-05T11:47:35.329994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.75698ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-08-05T11:47:35.33004Z","caller":"traceutil/trace.go:171","msg":"trace[1659906055] linearizableReadLoop","detail":"{readStateIndex:21914; appliedIndex:21912; }","duration":"252.154015ms","start":"2026-08-05T11:47:35.077206Z","end":"2026-08-05T11:47:35.32936Z","steps":["trace[1659906055] 'read index received'  (duration: 175.343067ms)","trace[1659906055] 'applied index is now lower than readState.Index'  (duration: 76.809328ms)"],"step_count":2}
{"level":"info","ts":"2026-08-05T11:47:35.330091Z","caller":"traceutil/trace.go:171","msg":"trace[43169540] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:21195; }","duration":"252.892564ms","start":"2026-08-05T11:47:35.077177Z","end":"2026-08-05T11:47:35.330069Z","steps":["trace[43169540] 'agreement among raft nodes before linearized reading'  (duration: 252.593886ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:47:35.330261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.166089ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"}
{"level":"info","ts":"2026-08-05T11:47:35.330305Z","caller":"traceutil/trace.go:171","msg":"trace[237916040] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:21195; }","duration":"235.251501ms","start":"2026-08-05T11:47:35.09504Z","end":"2026-08-05T11:47:35.330292Z","steps":["trace[237916040] 'agreement among raft nodes before linearized reading'  (duration: 235.107007ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:47:35.664045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.438551ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-05T11:47:35.664114Z","caller":"traceutil/trace.go:171","msg":"trace[1962569707] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:21198; }","duration":"102.555974ms","start":"2026-08-05T11:47:35.561543Z","end":"2026-08-05T11:47:35.664099Z","steps":["trace[1962569707] 'range keys from in-memory index tree'  (duration: 102.348619ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:47:35.664144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.747956ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"}
{"level":"info","ts":"2026-08-05T11:47:35.664175Z","caller":"traceutil/trace.go:171","msg":"trace[1035207226] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:21198; }","duration":"186.807498ms","start":"2026-08-05T11:47:35.477358Z","end":"2026-08-05T11:47:35.664166Z","steps":["trace[1035207226] 'range keys from in-memory index tree'  (duration: 186.612803ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:47:35.664302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.198233ms","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-05T11:47:35.664422Z","caller":"traceutil/trace.go:171","msg":"trace[1504285123] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:21198; }","duration":"159.337086ms","start":"2026-08-05T11:47:35.50503Z","end":"2026-08-05T11:47:35.664367Z","steps":["trace[1504285123] 'count revisions from in-memory index tree'  (duration: 159.059129ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:47:35.665744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.48276ms","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-05T11:47:35.665911Z","caller":"traceutil/trace.go:171","msg":"trace[442463118] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:21198; }","duration":"160.793904ms","start":"2026-08-05T11:47:35.505096Z","end":"2026-08-05T11:47:35.665889Z","steps":["trace[442463118] 'range keys from in-memory index tree'  (duration: 159.290965ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:47:35.830805Z","caller":"traceutil/trace.go:171","msg":"trace[2113015170] linearizableReadLoop","detail":"{readStateIndex:21918; appliedIndex:21917; }","duration":"150.73063ms","start":"2026-08-05T11:47:35.680044Z","end":"2026-08-05T11:47:35.830774Z","steps":["trace[2113015170] 'read index received'  (duration: 150.473834ms)","trace[2113015170] 'applied index is now lower than readState.Index'  (duration: 255.986µs)"],"step_count":2}
{"level":"info","ts":"2026-08-05T11:47:35.830932Z","caller":"traceutil/trace.go:171","msg":"trace[787328098] transaction","detail":"{read_only:false; response_revision:21199; number_of_response:1; }","duration":"153.593895ms","start":"2026-08-05T11:47:35.677327Z","end":"2026-08-05T11:47:35.830921Z","steps":["trace[787328098] 'process raft request'  (duration: 153.274897ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:47:35.831379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.302545ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"}
{"level":"info","ts":"2026-08-05T11:47:35.831477Z","caller":"traceutil/trace.go:171","msg":"trace[607023567] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:21199; }","duration":"151.404398ms","start":"2026-08-05T11:47:35.680031Z","end":"2026-08-05T11:47:35.831435Z","steps":["trace[607023567] 'agreement among raft nodes before linearized reading'  (duration: 151.148451ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:48:03.586589Z","caller":"traceutil/trace.go:171","msg":"trace[1055165852] linearizableReadLoop","detail":"{readStateIndex:22069; appliedIndex:22068; }","duration":"107.802332ms","start":"2026-08-05T11:48:03.478746Z","end":"2026-08-05T11:48:03.586548Z","steps":["trace[1055165852] 'read index received'  (duration: 94.175544ms)","trace[1055165852] 'applied index is now lower than readState.Index'  (duration: 13.625348ms)"],"step_count":2}
{"level":"info","ts":"2026-08-05T11:48:03.586681Z","caller":"traceutil/trace.go:171","msg":"trace[1310243650] transaction","detail":"{read_only:false; response_revision:21344; number_of_response:1; }","duration":"121.866412ms","start":"2026-08-05T11:48:03.464778Z","end":"2026-08-05T11:48:03.586645Z","steps":["trace[1310243650] 'process raft request'  (duration: 108.243154ms)","trace[1310243650] 'compare'  (duration: 13.409792ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-05T11:48:03.586837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.077319ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"}
{"level":"info","ts":"2026-08-05T11:48:03.586931Z","caller":"traceutil/trace.go:171","msg":"trace[1721950883] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:21344; }","duration":"108.214633ms","start":"2026-08-05T11:48:03.478693Z","end":"2026-08-05T11:48:03.586908Z","steps":["trace[1721950883] 'agreement among raft nodes before linearized reading'  (duration: 107.971986ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:48:53.744412Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19682}
{"level":"info","ts":"2026-08-05T11:48:53.84978Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19682,"took":"102.486643ms","hash":1130220825,"current-db-size-bytes":59686912,"current-db-size":"60 MB","current-db-size-in-use-bytes":29446144,"current-db-size-in-use":"29 MB"}
{"level":"info","ts":"2026-08-05T11:48:53.849849Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1130220825,"revision":19682,"compact-revision":17382}
{"level":"info","ts":"2026-08-05T11:51:42.154422Z","caller":"traceutil/trace.go:171","msg":"trace[975426749] transaction","detail":"{read_only:false; response_revision:23739; number_of_response:1; }","duration":"306.817984ms","start":"2026-08-05T11:51:41.847562Z","end":"2026-08-05T11:51:42.15438Z","steps":["trace[975426749] 'process raft request'  (duration: 273.495998ms)","trace[975426749] 'compare'  (duration: 32.73344ms)"],"step_count":2}
{"level":"info","ts":"2026-08-05T11:51:42.154456Z","caller":"traceutil/trace.go:171","msg":"trace[2094371443] transaction","detail":"{read_only:false; response_revision:23741; number_of_response:1; }","duration":"174.523058ms","start":"2026-08-05T11:51:41.979906Z","end":"2026-08-05T11:51:42.154429Z","steps":["trace[2094371443] 'process raft request'  (duration: 174.448446ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:51:42.154642Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T11:51:41.847517Z","time spent":"306.993748ms","remote":"127.0.0.1:46226","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":498,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:23696 > success:<request_put:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" value_size:442 >> failure:<request_range:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" > >"}
{"level":"info","ts":"2026-08-05T11:51:42.154476Z","caller":"traceutil/trace.go:171","msg":"trace[1522656133] transaction","detail":"{read_only:false; response_revision:23740; number_of_response:1; }","duration":"304.44329ms","start":"2026-08-05T11:51:41.849999Z","end":"2026-08-05T11:51:42.154442Z","steps":["trace[1522656133] 'process raft request'  (duration: 304.231105ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:51:42.15491Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-05T11:51:41.849973Z","time spent":"304.777929ms","remote":"127.0.0.1:46226","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" mod_revision:23564 > success:<request_put:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" value_size:416 >> failure:<request_range:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" > >"}
{"level":"info","ts":"2026-08-05T11:53:51.083042Z","caller":"traceutil/trace.go:171","msg":"trace[1525230042] linearizableReadLoop","detail":"{readStateIndex:25819; appliedIndex:25818; }","duration":"115.006957ms","start":"2026-08-05T11:53:50.968004Z","end":"2026-08-05T11:53:51.083011Z","steps":["trace[1525230042] 'read index received'  (duration: 89.876319ms)","trace[1525230042] 'applied index is now lower than readState.Index'  (duration: 25.129588ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-05T11:53:51.083151Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.12503ms","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:6"}
{"level":"info","ts":"2026-08-05T11:53:51.083175Z","caller":"traceutil/trace.go:171","msg":"trace[2017255317] range","detail":"{range_begin:/registry/rabbitmq.com/policies/; range_end:/registry/rabbitmq.com/policies0; response_count:0; response_revision:24988; }","duration":"115.180091ms","start":"2026-08-05T11:53:50.967987Z","end":"2026-08-05T11:53:51.083167Z","steps":["trace[2017255317] 'agreement among raft nodes before linearized reading'  (duration: 115.112559ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:53:51.083221Z","caller":"traceutil/trace.go:171","msg":"trace[1648501511] transaction","detail":"{read_only:false; response_revision:24988; number_of_response:1; }","duration":"130.908539ms","start":"2026-08-05T11:53:50.952281Z","end":"2026-08-05T11:53:51.083189Z","steps":["trace[1648501511] 'process raft request'  (duration: 105.652529ms)","trace[1648501511] 'compare'  (duration: 24.828949ms)"],"step_count":2}
{"level":"info","ts":"2026-08-05T11:53:52.052194Z","caller":"traceutil/trace.go:171","msg":"trace[1179230598] linearizableReadLoop","detail":"{readStateIndex:25828; appliedIndex:25826; }","duration":"100.293985ms","start":"2026-08-05T11:53:51.951862Z","end":"2026-08-05T11:53:52.052156Z","steps":["trace[1179230598] 'read index received'  (duration: 60.149168ms)","trace[1179230598] 'applied index is now lower than readState.Index'  (duration: 40.142697ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-05T11:53:52.052512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.643995ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"}
{"level":"info","ts":"2026-08-05T11:53:52.052594Z","caller":"traceutil/trace.go:171","msg":"trace[117943426] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24997; }","duration":"100.774908ms","start":"2026-08-05T11:53:51.951798Z","end":"2026-08-05T11:53:52.052573Z","steps":["trace[117943426] 'agreement among raft nodes before linearized reading'  (duration: 100.549572ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:53:53.75758Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":21898}
{"level":"info","ts":"2026-08-05T11:53:53.864207Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":21898,"took":"103.350276ms","hash":1865380411,"current-db-size-bytes":59686912,"current-db-size":"60 MB","current-db-size-in-use-bytes":44302336,"current-db-size-in-use":"44 MB"}
{"level":"info","ts":"2026-08-05T11:53:53.864267Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1865380411,"revision":21898,"compact-revision":19682}
{"level":"warn","ts":"2026-08-05T11:56:02.350541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.265013ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3415874564932356955 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:25977 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:18"}
{"level":"info","ts":"2026-08-05T11:56:02.351148Z","caller":"traceutil/trace.go:171","msg":"trace[529761794] transaction","detail":"{read_only:false; response_revision:25992; number_of_response:1; }","duration":"171.220628ms","start":"2026-08-05T11:56:02.179825Z","end":"2026-08-05T11:56:02.351046Z","steps":["trace[529761794] 'process raft request'  (duration: 41.357579ms)","trace[529761794] 'compare'  (duration: 129.13739ms)"],"step_count":2}
{"level":"info","ts":"2026-08-05T11:56:02.360709Z","caller":"traceutil/trace.go:171","msg":"trace[505777134] linearizableReadLoop","detail":"{readStateIndex:26853; appliedIndex:26851; }","duration":"121.280512ms","start":"2026-08-05T11:56:02.23941Z","end":"2026-08-05T11:56:02.360691Z","steps":["trace[505777134] 'read index received'  (duration: 54.264112ms)","trace[505777134] 'applied index is now lower than readState.Index'  (duration: 67.0153ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-05T11:56:02.360868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.442976ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/magnum-db-sync-4p4md\" ","response":"range_response_count:1 size:7261"}
{"level":"info","ts":"2026-08-05T11:56:02.360901Z","caller":"traceutil/trace.go:171","msg":"trace[925543531] range","detail":"{range_begin:/registry/pods/openstack/magnum-db-sync-4p4md; range_end:; response_count:1; response_revision:25992; }","duration":"121.510358ms","start":"2026-08-05T11:56:02.239383Z","end":"2026-08-05T11:56:02.360893Z","steps":["trace[925543531] 'agreement among raft nodes before linearized reading'  (duration: 121.373905ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:57:07.813581Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-0000000000006ad6.wal"}
{"level":"info","ts":"2026-08-05T11:58:44.467367Z","caller":"traceutil/trace.go:171","msg":"trace[600260721] linearizableReadLoop","detail":"{readStateIndex:28075; appliedIndex:28074; }","duration":"289.972133ms","start":"2026-08-05T11:58:44.177372Z","end":"2026-08-05T11:58:44.467344Z","steps":["trace[600260721] 'read index received'  (duration: 289.844549ms)","trace[600260721] 'applied index is now lower than readState.Index'  (duration: 126.814µs)"],"step_count":2}
{"level":"info","ts":"2026-08-05T11:58:44.467416Z","caller":"traceutil/trace.go:171","msg":"trace[1979856330] transaction","detail":"{read_only:false; response_revision:27180; number_of_response:1; }","duration":"291.719009ms","start":"2026-08-05T11:58:44.175681Z","end":"2026-08-05T11:58:44.4674Z","steps":["trace[1979856330] 'process raft request'  (duration: 291.523144ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:58:44.467522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.137507ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/auth-system/\" range_end:\"/registry/persistentvolumeclaims/auth-system0\" limit:500 ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-05T11:58:44.467566Z","caller":"traceutil/trace.go:171","msg":"trace[1133011990] range","detail":"{range_begin:/registry/persistentvolumeclaims/auth-system/; range_end:/registry/persistentvolumeclaims/auth-system0; response_count:0; response_revision:27180; }","duration":"290.193108ms","start":"2026-08-05T11:58:44.177358Z","end":"2026-08-05T11:58:44.467551Z","steps":["trace[1133011990] 'agreement among raft nodes before linearized reading'  (duration: 290.110586ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:58:44.467626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.351891ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/auth-system/keycloak\" ","response":"range_response_count:1 size:1156"}
{"level":"info","ts":"2026-08-05T11:58:44.467685Z","caller":"traceutil/trace.go:171","msg":"trace[2019166298] range","detail":"{range_begin:/registry/networkpolicies/auth-system/keycloak; range_end:; response_count:1; response_revision:27180; }","duration":"273.412802ms","start":"2026-08-05T11:58:44.194257Z","end":"2026-08-05T11:58:44.46767Z","steps":["trace[2019166298] 'agreement among raft nodes before linearized reading'  (duration: 273.252288ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:58:44.46764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.433404ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"}
{"level":"warn","ts":"2026-08-05T11:58:44.467731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.347233ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/auth-system/keycloak-0\" ","response":"range_response_count:1 size:7965"}
{"level":"info","ts":"2026-08-05T11:58:44.467799Z","caller":"traceutil/trace.go:171","msg":"trace[452084670] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:27180; }","duration":"261.62437ms","start":"2026-08-05T11:58:44.206164Z","end":"2026-08-05T11:58:44.467788Z","steps":["trace[452084670] 'agreement among raft nodes before linearized reading'  (duration: 261.392783ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:58:44.467821Z","caller":"traceutil/trace.go:171","msg":"trace[1032872792] range","detail":"{range_begin:/registry/pods/auth-system/keycloak-0; range_end:; response_count:1; response_revision:27180; }","duration":"220.477607ms","start":"2026-08-05T11:58:44.247325Z","end":"2026-08-05T11:58:44.467802Z","steps":["trace[1032872792] 'agreement among raft nodes before linearized reading'  (duration: 220.23034ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:58:51.342385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.922379ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/cert-manager/kube-prometheus-stack-ca\" ","response":"range_response_count:1 size:2543"}
{"level":"info","ts":"2026-08-05T11:58:51.342445Z","caller":"traceutil/trace.go:171","msg":"trace[1503154408] range","detail":"{range_begin:/registry/secrets/cert-manager/kube-prometheus-stack-ca; range_end:; response_count:1; response_revision:27237; }","duration":"119.020682ms","start":"2026-08-05T11:58:51.223413Z","end":"2026-08-05T11:58:51.342433Z","steps":["trace[1503154408] 'range keys from in-memory index tree'  (duration: 118.800585ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:58:53.768123Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":25013}
{"level":"info","ts":"2026-08-05T11:58:53.960578Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":25013,"took":"189.605026ms","hash":1107102232,"current-db-size-bytes":59686912,"current-db-size":"60 MB","current-db-size-in-use-bytes":30859264,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-08-05T11:58:53.960653Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1107102232,"revision":25013,"compact-revision":21898}
{"level":"info","ts":"2026-08-05T11:59:17.496527Z","caller":"traceutil/trace.go:171","msg":"trace[1535144377] linearizableReadLoop","detail":"{readStateIndex:28332; appliedIndex:28331; }","duration":"126.980833ms","start":"2026-08-05T11:59:17.369511Z","end":"2026-08-05T11:59:17.496492Z","steps":["trace[1535144377] 'read index received'  (duration: 87.101324ms)","trace[1535144377] 'applied index is now lower than readState.Index'  (duration: 39.878179ms)"],"step_count":2}
{"level":"info","ts":"2026-08-05T11:59:17.49666Z","caller":"traceutil/trace.go:171","msg":"trace[801640654] transaction","detail":"{read_only:false; response_revision:27428; number_of_response:1; }","duration":"131.527214ms","start":"2026-08-05T11:59:17.365074Z","end":"2026-08-05T11:59:17.496601Z","steps":["trace[801640654] 'process raft request'  (duration: 91.625764ms)","trace[801640654] 'compare'  (duration: 39.365366ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-05T11:59:17.496789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.261841ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/monitoring/kube-prometheus-stack-grafana\" ","response":"range_response_count:1 size:10941"}
{"level":"info","ts":"2026-08-05T11:59:17.49686Z","caller":"traceutil/trace.go:171","msg":"trace[1155575400] range","detail":"{range_begin:/registry/deployments/monitoring/kube-prometheus-stack-grafana; range_end:; response_count:1; response_revision:27428; }","duration":"127.359904ms","start":"2026-08-05T11:59:17.36948Z","end":"2026-08-05T11:59:17.49684Z","steps":["trace[1155575400] 'agreement among raft nodes before linearized reading'  (duration: 127.167388ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:59:28.856724Z","caller":"traceutil/trace.go:171","msg":"trace[164014790] linearizableReadLoop","detail":"{readStateIndex:28414; appliedIndex:28413; }","duration":"103.912081ms","start":"2026-08-05T11:59:28.752784Z","end":"2026-08-05T11:59:28.856696Z","steps":["trace[164014790] 'read index received'  (duration: 103.774257ms)","trace[164014790] 'applied index is now lower than readState.Index'  (duration: 136.834µs)"],"step_count":2}
{"level":"info","ts":"2026-08-05T11:59:28.856853Z","caller":"traceutil/trace.go:171","msg":"trace[1331444212] transaction","detail":"{read_only:false; response_revision:27508; number_of_response:1; }","duration":"155.322676ms","start":"2026-08-05T11:59:28.701516Z","end":"2026-08-05T11:59:28.856838Z","steps":["trace[1331444212] 'process raft request'  (duration: 155.023258ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:59:28.857154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.339612ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/kube-prometheus-stack-operator\" ","response":"range_response_count:1 size:1606"}
{"level":"info","ts":"2026-08-05T11:59:28.857255Z","caller":"traceutil/trace.go:171","msg":"trace[1186136710] range","detail":"{range_begin:/registry/services/specs/monitoring/kube-prometheus-stack-operator; range_end:; response_count:1; response_revision:27508; }","duration":"104.487606ms","start":"2026-08-05T11:59:28.752744Z","end":"2026-08-05T11:59:28.857232Z","steps":["trace[1186136710] 'agreement among raft nodes before linearized reading'  (duration: 104.24537ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T11:59:28.89814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.127852ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:1963"}
{"level":"info","ts":"2026-08-05T11:59:28.89824Z","caller":"traceutil/trace.go:171","msg":"trace[1191997154] range","detail":"{range_begin:/registry/services/specs/monitoring/kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:27509; }","duration":"143.258536ms","start":"2026-08-05T11:59:28.754963Z","end":"2026-08-05T11:59:28.898221Z","steps":["trace[1191997154] 'agreement among raft nodes before linearized reading'  (duration: 143.0399ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T11:59:29.062871Z","caller":"traceutil/trace.go:171","msg":"trace[601905007] transaction","detail":"{read_only:false; response_revision:27510; number_of_response:1; }","duration":"110.793333ms","start":"2026-08-05T11:59:28.952037Z","end":"2026-08-05T11:59:29.06283Z","steps":["trace[601905007] 'process raft request'  (duration: 106.277823ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-05T12:00:17.142091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.051196ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keystone-db-init-qxdq2\" ","response":"range_response_count:1 size:7380"}
{"level":"info","ts":"2026-08-05T12:00:17.142187Z","caller":"traceutil/trace.go:171","msg":"trace[1465122474] range","detail":"{range_begin:/registry/pods/openstack/keystone-db-init-qxdq2; range_end:; response_count:1; response_revision:27972; }","duration":"118.19716ms","start":"2026-08-05T12:00:17.023971Z","end":"2026-08-05T12:00:17.142168Z","steps":["trace[1465122474] 'range keys from in-memory index tree'  (duration: 117.868741ms)"],"step_count":1}
{"level":"info","ts":"2026-08-05T12:00:17.142747Z","caller":"traceutil/trace.go:171","msg":"trace[591772343] transaction","detail":"{read_only:false; response_revision:27973; number_of_response:1; }","duration":"107.272729ms","start":"2026-08-05T12:00:17.03544Z","end":"2026-08-05T12:00:17.142713Z","steps":["trace[591772343] 'process raft request'  (duration: 77.688524ms)","trace[591772343] 'compare'  (duration: 29.266597ms)"],"step_count":2}