{"level":"warn","ts":"2026-03-18T05:34:36.307478Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-03-18T05:34:36.307611Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.204:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://162.253.55.204:2380","--initial-cluster=instance=https://162.253.55.204:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.204:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.204: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-03-18T05:34:36.307716Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-03-18T05:34:36.307733Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.204:2380"]}
{"level":"info","ts":"2026-03-18T05:34:36.307763Z","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-03-18T05:34:36.309161Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.204:2379"]}
{"level":"info","ts":"2026-03-18T05:34:36.30925Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.204:2380"],"listen-peer-urls":["https://162.253.55.204:2380"],"advertise-client-urls":["https://162.253.55.204:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.204:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.204: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-03-18T05:34:36.314384Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.882425ms"}
{"level":"info","ts":"2026-03-18T05:34:36.323467Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"a11c20306510c1f7","cluster-id":"97da89d0cbebd2b5"}
{"level":"info","ts":"2026-03-18T05:34:36.323565Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 switched to configuration voters=()"}
{"level":"info","ts":"2026-03-18T05:34:36.323598Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 became follower at term 0"}
{"level":"info","ts":"2026-03-18T05:34:36.323618Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft a11c20306510c1f7 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-03-18T05:34:36.323631Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 became follower at term 1"}
{"level":"info","ts":"2026-03-18T05:34:36.323687Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 switched to configuration voters=(11609189331680412151)"}
{"level":"warn","ts":"2026-03-18T05:34:36.333488Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-03-18T05:34:36.335999Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-03-18T05:34:36.338285Z","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-03-18T05:34:36.341298Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"a11c20306510c1f7","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-03-18T05:34:36.342417Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"a11c20306510c1f7","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-03-18T05:34:36.342726Z","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-03-18T05:34:36.342899Z","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-03-18T05:34:36.34292Z","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-03-18T05:34:36.345388Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 switched to configuration voters=(11609189331680412151)"}
{"level":"info","ts":"2026-03-18T05:34:36.345595Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"97da89d0cbebd2b5","local-member-id":"a11c20306510c1f7","added-peer-id":"a11c20306510c1f7","added-peer-peer-urls":["https://162.253.55.204:2380"]}
{"level":"info","ts":"2026-03-18T05:34:36.348189Z","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-03-18T05:34:36.348262Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.204:2380"}
{"level":"info","ts":"2026-03-18T05:34:36.34832Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.204:2380"}
{"level":"info","ts":"2026-03-18T05:34:36.348804Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"a11c20306510c1f7","initial-advertise-peer-urls":["https://162.253.55.204:2380"],"listen-peer-urls":["https://162.253.55.204:2380"],"advertise-client-urls":["https://162.253.55.204:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.204:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-03-18T05:34:36.348874Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-03-18T05:34:36.82458Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 is starting a new election at term 1"}
{"level":"info","ts":"2026-03-18T05:34:36.824634Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 became pre-candidate at term 1"}
{"level":"info","ts":"2026-03-18T05:34:36.824679Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 received MsgPreVoteResp from a11c20306510c1f7 at term 1"}
{"level":"info","ts":"2026-03-18T05:34:36.824702Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 became candidate at term 2"}
{"level":"info","ts":"2026-03-18T05:34:36.824713Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 received MsgVoteResp from a11c20306510c1f7 at term 2"}
{"level":"info","ts":"2026-03-18T05:34:36.824731Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 became leader at term 2"}
{"level":"info","ts":"2026-03-18T05:34:36.824745Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: a11c20306510c1f7 elected leader a11c20306510c1f7 at term 2"}
{"level":"info","ts":"2026-03-18T05:34:36.825876Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-18T05:34:36.826819Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-18T05:34:36.826818Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"a11c20306510c1f7","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.204:2379]}","request-path":"/0/members/a11c20306510c1f7/attributes","cluster-id":"97da89d0cbebd2b5","publish-timeout":"7s"}
{"level":"info","ts":"2026-03-18T05:34:36.826866Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-18T05:34:36.827158Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-03-18T05:34:36.827258Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-03-18T05:34:36.827517Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"97da89d0cbebd2b5","local-member-id":"a11c20306510c1f7","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-18T05:34:36.827666Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-18T05:34:36.827717Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-18T05:34:36.829143Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-03-18T05:34:36.830334Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.204:2379"}
{"level":"info","ts":"2026-03-18T05:34:59.447665Z","caller":"traceutil/trace.go:171","msg":"trace[771718486] transaction","detail":"{read_only:false; response_revision:416; number_of_response:1; }","duration":"121.329778ms","start":"2026-03-18T05:34:59.326265Z","end":"2026-03-18T05:34:59.447595Z","steps":["trace[771718486] 'process raft request'  (duration: 121.043552ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T05:35:04.603409Z","caller":"traceutil/trace.go:171","msg":"trace[1045499309] transaction","detail":"{read_only:false; response_revision:428; number_of_response:1; }","duration":"186.224334ms","start":"2026-03-18T05:35:04.417138Z","end":"2026-03-18T05:35:04.603363Z","steps":["trace[1045499309] 'process raft request'  (duration: 185.912937ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T05:35:12.78988Z","caller":"traceutil/trace.go:171","msg":"trace[235763544] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"151.635252ms","start":"2026-03-18T05:35:12.638205Z","end":"2026-03-18T05:35:12.78984Z","steps":["trace[235763544] 'process raft request'  (duration: 151.277333ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T05:35:12.946833Z","caller":"traceutil/trace.go:171","msg":"trace[220512251] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"150.971565ms","start":"2026-03-18T05:35:12.795828Z","end":"2026-03-18T05:35:12.9468Z","steps":["trace[220512251] 'process raft request'  (duration: 138.239576ms)","trace[220512251] 'compare'  (duration: 12.593366ms)"],"step_count":2}
{"level":"info","ts":"2026-03-18T05:35:14.91049Z","caller":"traceutil/trace.go:171","msg":"trace[1546654973] linearizableReadLoop","detail":"{readStateIndex:541; appliedIndex:540; }","duration":"100.678698ms","start":"2026-03-18T05:35:14.809788Z","end":"2026-03-18T05:35:14.910467Z","steps":["trace[1546654973] 'read index received'  (duration: 100.38994ms)","trace[1546654973] 'applied index is now lower than readState.Index'  (duration: 287.718µs)"],"step_count":2}
{"level":"info","ts":"2026-03-18T05:35:14.910572Z","caller":"traceutil/trace.go:171","msg":"trace[1740235111] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"128.79639ms","start":"2026-03-18T05:35:14.781739Z","end":"2026-03-18T05:35:14.910536Z","steps":["trace[1740235111] 'process raft request'  (duration: 128.573635ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T05:35:14.910681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.879542ms","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-03-18T05:35:14.910748Z","caller":"traceutil/trace.go:171","msg":"trace[1281608235] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:523; }","duration":"101.007195ms","start":"2026-03-18T05:35:14.809731Z","end":"2026-03-18T05:35:14.910738Z","steps":["trace[1281608235] 'agreement among raft nodes before linearized reading'  (duration: 100.839871ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T05:36:26.509773Z","caller":"traceutil/trace.go:171","msg":"trace[714600076] transaction","detail":"{read_only:false; response_revision:1564; number_of_response:1; }","duration":"434.141035ms","start":"2026-03-18T05:36:26.075602Z","end":"2026-03-18T05:36:26.509743Z","steps":["trace[714600076] 'process raft request'  (duration: 415.49972ms)","trace[714600076] 'compare'  (duration: 18.318447ms)"],"step_count":2}
{"level":"info","ts":"2026-03-18T05:36:26.50981Z","caller":"traceutil/trace.go:171","msg":"trace[327698335] linearizableReadLoop","detail":"{readStateIndex:1627; appliedIndex:1626; }","duration":"400.183795ms","start":"2026-03-18T05:36:26.109547Z","end":"2026-03-18T05:36:26.509731Z","steps":["trace[327698335] 'read index received'  (duration: 381.445898ms)","trace[327698335] 'applied index is now lower than readState.Index'  (duration: 18.736697ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-18T05:36:26.510071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"400.505353ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"}
{"level":"info","ts":"2026-03-18T05:36:26.510124Z","caller":"traceutil/trace.go:171","msg":"trace[715422535] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1564; }","duration":"400.605325ms","start":"2026-03-18T05:36:26.109502Z","end":"2026-03-18T05:36:26.510108Z","steps":["trace[715422535] 'agreement among raft nodes before linearized reading'  (duration: 400.349389ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T05:36:26.51016Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T05:36:26.109489Z","time spent":"400.661867ms","remote":"127.0.0.1:36216","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5436,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "}
{"level":"warn","ts":"2026-03-18T05:36:26.510521Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T05:36:26.07557Z","time spent":"434.32854ms","remote":"127.0.0.1:59542","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3732,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c337b084-39e4-4533-b563-af7d9d5f4c9b\" mod_revision:1527 > success:<request_put:<key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c337b084-39e4-4533-b563-af7d9d5f4c9b\" value_size:3632 >> failure:<request_range:<key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c337b084-39e4-4533-b563-af7d9d5f4c9b\" > >"}
{"level":"info","ts":"2026-03-18T05:36:26.949564Z","caller":"traceutil/trace.go:171","msg":"trace[1823526653] transaction","detail":"{read_only:false; response_revision:1565; number_of_response:1; }","duration":"223.370368ms","start":"2026-03-18T05:36:26.72616Z","end":"2026-03-18T05:36:26.94953Z","steps":["trace[1823526653] 'process raft request'  (duration: 223.166323ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T05:36:39.645081Z","caller":"traceutil/trace.go:171","msg":"trace[1156762065] transaction","detail":"{read_only:false; response_revision:1668; number_of_response:1; }","duration":"223.825788ms","start":"2026-03-18T05:36:39.421229Z","end":"2026-03-18T05:36:39.645055Z","steps":["trace[1156762065] 'process raft request'  (duration: 220.623032ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T05:36:39.645274Z","caller":"traceutil/trace.go:171","msg":"trace[676396852] transaction","detail":"{read_only:false; response_revision:1669; number_of_response:1; }","duration":"222.136759ms","start":"2026-03-18T05:36:39.423106Z","end":"2026-03-18T05:36:39.645243Z","steps":["trace[676396852] 'process raft request'  (duration: 221.905193ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T05:36:39.896421Z","caller":"traceutil/trace.go:171","msg":"trace[1008718057] transaction","detail":"{read_only:false; response_revision:1671; number_of_response:1; }","duration":"190.578716ms","start":"2026-03-18T05:36:39.705786Z","end":"2026-03-18T05:36:39.896365Z","steps":["trace[1008718057] 'process raft request'  (duration: 189.90448ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T05:37:11.336601Z","caller":"traceutil/trace.go:171","msg":"trace[1796205178] transaction","detail":"{read_only:false; response_revision:1840; number_of_response:1; }","duration":"143.537974ms","start":"2026-03-18T05:37:11.193035Z","end":"2026-03-18T05:37:11.336573Z","steps":["trace[1796205178] 'process raft request'  (duration: 143.35419ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T05:37:17.982626Z","caller":"traceutil/trace.go:171","msg":"trace[1335228102] transaction","detail":"{read_only:false; response_revision:1872; number_of_response:1; }","duration":"207.407857ms","start":"2026-03-18T05:37:17.775184Z","end":"2026-03-18T05:37:17.982592Z","steps":["trace[1335228102] 'process raft request'  (duration: 207.236213ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T05:37:18.257469Z","caller":"traceutil/trace.go:171","msg":"trace[1714330009] linearizableReadLoop","detail":"{readStateIndex:1947; appliedIndex:1945; }","duration":"429.450213ms","start":"2026-03-18T05:37:17.82798Z","end":"2026-03-18T05:37:18.25743Z","steps":["trace[1714330009] 'read index received'  (duration: 154.506305ms)","trace[1714330009] 'applied index is now lower than readState.Index'  (duration: 274.941628ms)"],"step_count":2}
{"level":"info","ts":"2026-03-18T05:37:18.257529Z","caller":"traceutil/trace.go:171","msg":"trace[536267077] transaction","detail":"{read_only:false; response_revision:1873; number_of_response:1; }","duration":"480.689606ms","start":"2026-03-18T05:37:17.776807Z","end":"2026-03-18T05:37:18.257497Z","steps":["trace[536267077] 'process raft request'  (duration: 473.863143ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T05:37:18.257712Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T05:37:17.776765Z","time spent":"480.838859ms","remote":"127.0.0.1:59612","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:1864 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-03-18T05:37:18.257804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"429.812402ms","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-03-18T05:37:18.257855Z","caller":"traceutil/trace.go:171","msg":"trace[1956716354] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1873; }","duration":"429.924246ms","start":"2026-03-18T05:37:17.827916Z","end":"2026-03-18T05:37:18.25784Z","steps":["trace[1956716354] 'agreement among raft nodes before linearized reading'  (duration: 429.68751ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T05:37:18.257895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T05:37:17.827872Z","time spent":"430.013748ms","remote":"127.0.0.1:59612","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-03-18T05:37:18.279472Z","caller":"traceutil/trace.go:171","msg":"trace[2104275070] transaction","detail":"{read_only:false; response_revision:1874; number_of_response:1; }","duration":"222.070587ms","start":"2026-03-18T05:37:18.057369Z","end":"2026-03-18T05:37:18.279439Z","steps":["trace[2104275070] 'process raft request'  (duration: 221.881133ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T05:37:18.279652Z","caller":"traceutil/trace.go:171","msg":"trace[580518814] transaction","detail":"{read_only:false; response_revision:1875; number_of_response:1; }","duration":"135.561804ms","start":"2026-03-18T05:37:18.144051Z","end":"2026-03-18T05:37:18.279613Z","steps":["trace[580518814] 'process raft request'  (duration: 135.342609ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T05:37:18.279693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"440.546408ms","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-03-18T05:37:18.279757Z","caller":"traceutil/trace.go:171","msg":"trace[814933827] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1875; }","duration":"440.63036ms","start":"2026-03-18T05:37:17.839113Z","end":"2026-03-18T05:37:18.279743Z","steps":["trace[814933827] 'agreement among raft nodes before linearized reading'  (duration: 440.420625ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T05:37:18.279804Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T05:37:17.839105Z","time spent":"440.691222ms","remote":"127.0.0.1:59612","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-03-18T05:37:18.279752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.668667ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"}
{"level":"info","ts":"2026-03-18T05:37:18.279956Z","caller":"traceutil/trace.go:171","msg":"trace[2066298658] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1875; }","duration":"330.891832ms","start":"2026-03-18T05:37:17.949022Z","end":"2026-03-18T05:37:18.279914Z","steps":["trace[2066298658] 'agreement among raft nodes before linearized reading'  (duration: 330.634646ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T05:37:18.280028Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T05:37:17.949002Z","time spent":"331.007546ms","remote":"127.0.0.1:36216","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5436,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "}
{"level":"info","ts":"2026-03-18T05:38:08.600465Z","caller":"traceutil/trace.go:171","msg":"trace[1395102984] transaction","detail":"{read_only:false; response_revision:2294; number_of_response:1; }","duration":"103.981018ms","start":"2026-03-18T05:38:08.496456Z","end":"2026-03-18T05:38:08.600437Z","steps":["trace[1395102984] 'process raft request'  (duration: 103.761323ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T05:38:43.681183Z","caller":"traceutil/trace.go:171","msg":"trace[807839542] linearizableReadLoop","detail":"{readStateIndex:2587; appliedIndex:2586; }","duration":"136.884902ms","start":"2026-03-18T05:38:43.544268Z","end":"2026-03-18T05:38:43.681153Z","steps":["trace[807839542] 'read index received'  (duration: 136.589775ms)","trace[807839542] 'applied index is now lower than readState.Index'  (duration: 293.957µs)"],"step_count":2}
{"level":"info","ts":"2026-03-18T05:38:43.681368Z","caller":"traceutil/trace.go:171","msg":"trace[1285287095] transaction","detail":"{read_only:false; response_revision:2487; number_of_response:1; }","duration":"165.996799ms","start":"2026-03-18T05:38:43.515258Z","end":"2026-03-18T05:38:43.681255Z","steps":["trace[1285287095] 'process raft request'  (duration: 165.708643ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T05:38:43.682114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.808194ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"}
{"level":"info","ts":"2026-03-18T05:38:43.682253Z","caller":"traceutil/trace.go:171","msg":"trace[1414740244] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2487; }","duration":"138.004399ms","start":"2026-03-18T05:38:43.544219Z","end":"2026-03-18T05:38:43.682223Z","steps":["trace[1414740244] 'agreement among raft nodes before linearized reading'  (duration: 137.051356ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T05:38:43.850486Z","caller":"traceutil/trace.go:171","msg":"trace[166233203] transaction","detail":"{read_only:false; response_revision:2488; number_of_response:1; }","duration":"112.751383ms","start":"2026-03-18T05:38:43.737697Z","end":"2026-03-18T05:38:43.850449Z","steps":["trace[166233203] 'process raft request'  (duration: 64.587679ms)","trace[166233203] 'compare'  (duration: 48.048311ms)"],"step_count":2}
{"level":"info","ts":"2026-03-18T05:41:20.30411Z","caller":"traceutil/trace.go:171","msg":"trace[1282523231] transaction","detail":"{read_only:false; response_revision:3437; number_of_response:1; }","duration":"158.993893ms","start":"2026-03-18T05:41:20.14507Z","end":"2026-03-18T05:41:20.304064Z","steps":["trace[1282523231] 'process raft request'  (duration: 158.774798ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T05:42:49.274523Z","caller":"traceutil/trace.go:171","msg":"trace[2071589150] transaction","detail":"{read_only:false; response_revision:4497; number_of_response:1; }","duration":"118.420697ms","start":"2026-03-18T05:42:49.156069Z","end":"2026-03-18T05:42:49.27449Z","steps":["trace[2071589150] 'process raft request'  (duration: 110.166551ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T05:42:49.283021Z","caller":"traceutil/trace.go:171","msg":"trace[309696425] transaction","detail":"{read_only:false; response_revision:4498; number_of_response:1; }","duration":"126.49909ms","start":"2026-03-18T05:42:49.156507Z","end":"2026-03-18T05:42:49.283006Z","steps":["trace[309696425] 'process raft request'  (duration: 126.296125ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T05:42:49.283454Z","caller":"traceutil/trace.go:171","msg":"trace[1773187663] transaction","detail":"{read_only:false; response_revision:4499; number_of_response:1; }","duration":"104.485726ms","start":"2026-03-18T05:42:49.178936Z","end":"2026-03-18T05:42:49.283422Z","steps":["trace[1773187663] 'process raft request'  (duration: 104.034005ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T05:42:49.284157Z","caller":"traceutil/trace.go:171","msg":"trace[786426209] linearizableReadLoop","detail":"{readStateIndex:4677; appliedIndex:4675; }","duration":"126.723156ms","start":"2026-03-18T05:42:49.157409Z","end":"2026-03-18T05:42:49.284132Z","steps":["trace[786426209] 'read index received'  (duration: 108.893931ms)","trace[786426209] 'applied index is now lower than readState.Index'  (duration: 17.828485ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-18T05:42:49.284606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.165386ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/monitoring/goldpinger\" ","response":"range_response_count:1 size:3910"}
{"level":"info","ts":"2026-03-18T05:42:49.284699Z","caller":"traceutil/trace.go:171","msg":"trace[211551433] range","detail":"{range_begin:/registry/daemonsets/monitoring/goldpinger; range_end:; response_count:1; response_revision:4500; }","duration":"127.297129ms","start":"2026-03-18T05:42:49.15738Z","end":"2026-03-18T05:42:49.284677Z","steps":["trace[211551433] 'agreement among raft nodes before linearized reading'  (duration: 127.044813ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T05:42:49.28484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.675192ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:22 size:777977"}
{"level":"info","ts":"2026-03-18T05:42:49.284885Z","caller":"traceutil/trace.go:171","msg":"trace[518252965] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:22; response_revision:4500; }","duration":"107.769135ms","start":"2026-03-18T05:42:49.177105Z","end":"2026-03-18T05:42:49.284874Z","steps":["trace[518252965] 'agreement among raft nodes before linearized reading'  (duration: 107.398856ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T05:42:54.502051Z","caller":"traceutil/trace.go:171","msg":"trace[1894281563] transaction","detail":"{read_only:false; response_revision:4659; number_of_response:1; }","duration":"114.422623ms","start":"2026-03-18T05:42:54.387599Z","end":"2026-03-18T05:42:54.502022Z","steps":["trace[1894281563] 'process raft request'  (duration: 114.327331ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T05:42:54.502134Z","caller":"traceutil/trace.go:171","msg":"trace[821591537] linearizableReadLoop","detail":"{readStateIndex:4848; appliedIndex:4841; }","duration":"106.961985ms","start":"2026-03-18T05:42:54.395152Z","end":"2026-03-18T05:42:54.502114Z","steps":["trace[821591537] 'read index received'  (duration: 53.214356ms)","trace[821591537] 'applied index is now lower than readState.Index'  (duration: 53.746779ms)"],"step_count":2}
{"level":"info","ts":"2026-03-18T05:42:54.502229Z","caller":"traceutil/trace.go:171","msg":"trace[2145767783] transaction","detail":"{read_only:false; response_revision:4660; number_of_response:1; }","duration":"114.512204ms","start":"2026-03-18T05:42:54.387704Z","end":"2026-03-18T05:42:54.502216Z","steps":["trace[2145767783] 'process raft request'  (duration: 114.250638ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T05:42:54.502369Z","caller":"traceutil/trace.go:171","msg":"trace[807466070] transaction","detail":"{read_only:false; response_revision:4658; number_of_response:1; }","duration":"115.954459ms","start":"2026-03-18T05:42:54.386399Z","end":"2026-03-18T05:42:54.502353Z","steps":["trace[807466070] 'process raft request'  (duration: 61.948274ms)","trace[807466070] 'compare'  (duration: 53.428951ms)"],"step_count":2}
{"level":"info","ts":"2026-03-18T05:42:54.502507Z","caller":"traceutil/trace.go:171","msg":"trace[1237318711] transaction","detail":"{read_only:false; response_revision:4662; number_of_response:1; }","duration":"114.106914ms","start":"2026-03-18T05:42:54.388389Z","end":"2026-03-18T05:42:54.502496Z","steps":["trace[1237318711] 'process raft request'  (duration: 113.603752ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T05:42:54.502562Z","caller":"traceutil/trace.go:171","msg":"trace[849151213] transaction","detail":"{read_only:false; response_revision:4663; number_of_response:1; }","duration":"110.283184ms","start":"2026-03-18T05:42:54.392254Z","end":"2026-03-18T05:42:54.502538Z","steps":["trace[849151213] 'process raft request'  (duration: 109.756262ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T05:42:54.502556Z","caller":"traceutil/trace.go:171","msg":"trace[1060653974] transaction","detail":"{read_only:false; response_revision:4664; number_of_response:1; }","duration":"109.72879ms","start":"2026-03-18T05:42:54.392778Z","end":"2026-03-18T05:42:54.502506Z","steps":["trace[1060653974] 'process raft request'  (duration: 109.254499ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T05:42:54.502706Z","caller":"traceutil/trace.go:171","msg":"trace[769187973] transaction","detail":"{read_only:false; response_revision:4665; number_of_response:1; }","duration":"106.530194ms","start":"2026-03-18T05:42:54.395987Z","end":"2026-03-18T05:42:54.502518Z","steps":["trace[769187973] 'process raft request'  (duration: 106.083774ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T05:42:54.5027Z","caller":"traceutil/trace.go:171","msg":"trace[70715630] transaction","detail":"{read_only:false; response_revision:4661; number_of_response:1; }","duration":"114.878173ms","start":"2026-03-18T05:42:54.387744Z","end":"2026-03-18T05:42:54.502622Z","steps":["trace[70715630] 'process raft request'  (duration: 114.232088ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T05:42:54.502929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.741433ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config\" ","response":"range_response_count:1 size:708"}
{"level":"info","ts":"2026-03-18T05:42:54.502962Z","caller":"traceutil/trace.go:171","msg":"trace[103835852] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config; range_end:; response_count:1; response_revision:4665; }","duration":"107.827936ms","start":"2026-03-18T05:42:54.395124Z","end":"2026-03-18T05:42:54.502952Z","steps":["trace[103835852] 'agreement among raft nodes before linearized reading'  (duration: 107.442626ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T05:42:54.665582Z","caller":"traceutil/trace.go:171","msg":"trace[1283110465] transaction","detail":"{read_only:false; response_revision:4671; number_of_response:1; }","duration":"122.482705ms","start":"2026-03-18T05:42:54.543061Z","end":"2026-03-18T05:42:54.665543Z","steps":["trace[1283110465] 'process raft request'  (duration: 67.198019ms)","trace[1283110465] 'compare'  (duration: 54.897796ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-18T05:42:54.666045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.512275ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"}
{"level":"info","ts":"2026-03-18T05:42:54.666092Z","caller":"traceutil/trace.go:171","msg":"trace[906037490] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4671; }","duration":"114.616747ms","start":"2026-03-18T05:42:54.551459Z","end":"2026-03-18T05:42:54.666075Z","steps":["trace[906037490] 'agreement among raft nodes before linearized reading'  (duration: 114.405762ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T05:42:54.666383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.559519ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:14497"}
{"level":"info","ts":"2026-03-18T05:42:54.666417Z","caller":"traceutil/trace.go:171","msg":"trace[1184237813] range","detail":"{range_begin:/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4671; }","duration":"115.60816ms","start":"2026-03-18T05:42:54.550799Z","end":"2026-03-18T05:42:54.666407Z","steps":["trace[1184237813] 'agreement among raft nodes before linearized reading'  (duration: 115.462637ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T05:42:54.666678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.441223ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:7 size:62984"}
{"level":"info","ts":"2026-03-18T05:42:54.666706Z","caller":"traceutil/trace.go:171","msg":"trace[462611897] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:7; response_revision:4671; }","duration":"122.511625ms","start":"2026-03-18T05:42:54.544186Z","end":"2026-03-18T05:42:54.666698Z","steps":["trace[462611897] 'agreement among raft nodes before linearized reading'  (duration: 122.371842ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T05:43:05.556765Z","caller":"traceutil/trace.go:171","msg":"trace[1209573929] linearizableReadLoop","detail":"{readStateIndex:5054; appliedIndex:5053; }","duration":"173.849396ms","start":"2026-03-18T05:43:05.382884Z","end":"2026-03-18T05:43:05.556733Z","steps":["trace[1209573929] 'read index received'  (duration: 172.087045ms)","trace[1209573929] 'applied index is now lower than readState.Index'  (duration: 1.760721ms)"],"step_count":2}
{"level":"info","ts":"2026-03-18T05:43:05.556951Z","caller":"traceutil/trace.go:171","msg":"trace[1126586104] transaction","detail":"{read_only:false; response_revision:4864; number_of_response:1; }","duration":"220.617988ms","start":"2026-03-18T05:43:05.33632Z","end":"2026-03-18T05:43:05.556938Z","steps":["trace[1126586104] 'process raft request'  (duration: 218.639281ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T05:43:05.557075Z","caller":"traceutil/trace.go:171","msg":"trace[736272719] transaction","detail":"{read_only:false; response_revision:4865; number_of_response:1; }","duration":"141.960777ms","start":"2026-03-18T05:43:05.415069Z","end":"2026-03-18T05:43:05.55703Z","steps":["trace[736272719] 'process raft request'  (duration: 141.626319ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T05:43:05.557292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.378549ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-18T05:43:05.557428Z","caller":"traceutil/trace.go:171","msg":"trace[1137166985] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4865; }","duration":"174.574853ms","start":"2026-03-18T05:43:05.382822Z","end":"2026-03-18T05:43:05.557397Z","steps":["trace[1137166985] 'agreement among raft nodes before linearized reading'  (duration: 174.329728ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T05:43:05.557678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.47267ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-03-18T05:43:05.558436Z","caller":"traceutil/trace.go:171","msg":"trace[2031677040] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4865; }","duration":"135.313679ms","start":"2026-03-18T05:43:05.423099Z","end":"2026-03-18T05:43:05.558413Z","steps":["trace[2031677040] 'agreement among raft nodes before linearized reading'  (duration: 134.032529ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T05:43:06.4971Z","caller":"traceutil/trace.go:171","msg":"trace[469351616] linearizableReadLoop","detail":"{readStateIndex:5074; appliedIndex:5069; }","duration":"104.365112ms","start":"2026-03-18T05:43:06.392708Z","end":"2026-03-18T05:43:06.497073Z","steps":["trace[469351616] 'read index received'  (duration: 92.045609ms)","trace[469351616] 'applied index is now lower than readState.Index'  (duration: 12.318123ms)"],"step_count":2}
{"level":"info","ts":"2026-03-18T05:43:06.497159Z","caller":"traceutil/trace.go:171","msg":"trace[2091606804] transaction","detail":"{read_only:false; response_revision:4884; number_of_response:1; }","duration":"106.193067ms","start":"2026-03-18T05:43:06.390936Z","end":"2026-03-18T05:43:06.497129Z","steps":["trace[2091606804] 'process raft request'  (duration: 105.951831ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T05:43:06.497388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.65908ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-prometheus.189dd91ebcd2a1b5\" ","response":"range_response_count:1 size:745"}
{"level":"info","ts":"2026-03-18T05:43:06.49749Z","caller":"traceutil/trace.go:171","msg":"trace[1024396020] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-prometheus.189dd91ebcd2a1b5; range_end:; response_count:1; response_revision:4884; }","duration":"104.795812ms","start":"2026-03-18T05:43:06.392662Z","end":"2026-03-18T05:43:06.497458Z","steps":["trace[1024396020] 'agreement among raft nodes before linearized reading'  (duration: 104.552067ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T05:43:07.009284Z","caller":"traceutil/trace.go:171","msg":"trace[833242098] transaction","detail":"{read_only:false; response_revision:4888; number_of_response:1; }","duration":"197.599422ms","start":"2026-03-18T05:43:06.811658Z","end":"2026-03-18T05:43:07.009258Z","steps":["trace[833242098] 'process raft request'  (duration: 197.396147ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T05:43:09.749413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.23017ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13976812589482462891 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:4890 > 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:16"}
{"level":"info","ts":"2026-03-18T05:43:09.749635Z","caller":"traceutil/trace.go:171","msg":"trace[14135911] transaction","detail":"{read_only:false; response_revision:4900; number_of_response:1; }","duration":"150.313757ms","start":"2026-03-18T05:43:09.599273Z","end":"2026-03-18T05:43:09.749587Z","steps":["trace[14135911] 'process raft request'  (duration: 37.620006ms)","trace[14135911] 'compare'  (duration: 112.034975ms)"],"step_count":2}
{"level":"info","ts":"2026-03-18T05:43:14.605748Z","caller":"traceutil/trace.go:171","msg":"trace[2031424901] linearizableReadLoop","detail":"{readStateIndex:5158; appliedIndex:5157; }","duration":"176.163561ms","start":"2026-03-18T05:43:14.429545Z","end":"2026-03-18T05:43:14.605708Z","steps":["trace[2031424901] 'read index received'  (duration: 175.784011ms)","trace[2031424901] 'applied index is now lower than readState.Index'  (duration: 377.85µs)"],"step_count":2}
{"level":"info","ts":"2026-03-18T05:43:14.605883Z","caller":"traceutil/trace.go:171","msg":"trace[1892358524] transaction","detail":"{read_only:false; response_revision:4966; number_of_response:1; }","duration":"183.749462ms","start":"2026-03-18T05:43:14.422076Z","end":"2026-03-18T05:43:14.605825Z","steps":["trace[1892358524] 'process raft request'  (duration: 183.397013ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T05:43:14.60614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.55004ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"}
{"level":"info","ts":"2026-03-18T05:43:14.606206Z","caller":"traceutil/trace.go:171","msg":"trace[24623135] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4966; }","duration":"176.649302ms","start":"2026-03-18T05:43:14.429539Z","end":"2026-03-18T05:43:14.606188Z","steps":["trace[24623135] 'agreement among raft nodes before linearized reading'  (duration: 176.323275ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T05:43:21.681446Z","caller":"traceutil/trace.go:171","msg":"trace[174520983] transaction","detail":"{read_only:false; response_revision:5055; number_of_response:1; }","duration":"113.012659ms","start":"2026-03-18T05:43:21.568391Z","end":"2026-03-18T05:43:21.681403Z","steps":["trace[174520983] 'process raft request'  (duration: 103.102254ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T05:43:47.098456Z","caller":"traceutil/trace.go:171","msg":"trace[1267587177] linearizableReadLoop","detail":"{readStateIndex:5580; appliedIndex:5579; }","duration":"143.991855ms","start":"2026-03-18T05:43:46.954436Z","end":"2026-03-18T05:43:47.098427Z","steps":["trace[1267587177] 'read index received'  (duration: 143.751ms)","trace[1267587177] 'applied index is now lower than readState.Index'  (duration: 239.175µs)"],"step_count":2}
{"level":"info","ts":"2026-03-18T05:43:47.098505Z","caller":"traceutil/trace.go:171","msg":"trace[1617068310] transaction","detail":"{read_only:false; response_revision:5377; number_of_response:1; }","duration":"327.317556ms","start":"2026-03-18T05:43:46.771154Z","end":"2026-03-18T05:43:47.098472Z","steps":["trace[1617068310] 'process raft request'  (duration: 327.05281ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T05:43:47.098669Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T05:43:46.771128Z","time spent":"327.45206ms","remote":"127.0.0.1:59542","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":12117,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/pods/openstack/keystone-api-6d7c978cc5-9qzvb\" mod_revision:5347 > success:<request_put:<key:\"/registry/pods/openstack/keystone-api-6d7c978cc5-9qzvb\" value_size:12055 >> failure:<request_range:<key:\"/registry/pods/openstack/keystone-api-6d7c978cc5-9qzvb\" > >"}
{"level":"warn","ts":"2026-03-18T05:43:47.098694Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.259731ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-cl7zm\" ","response":"range_response_count:1 size:6531"}
{"level":"info","ts":"2026-03-18T05:43:47.098846Z","caller":"traceutil/trace.go:171","msg":"trace[167315413] range","detail":"{range_begin:/registry/pods/openstack/keepalived-cl7zm; range_end:; response_count:1; response_revision:5377; }","duration":"144.471118ms","start":"2026-03-18T05:43:46.954355Z","end":"2026-03-18T05:43:47.098826Z","steps":["trace[167315413] 'agreement among raft nodes before linearized reading'  (duration: 144.17789ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T05:44:36.854921Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2751}
{"level":"info","ts":"2026-03-18T05:44:36.913936Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2751,"took":"57.687163ms","hash":1464371657,"current-db-size-bytes":41148416,"current-db-size":"41 MB","current-db-size-in-use-bytes":30666752,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-03-18T05:44:36.914017Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1464371657,"revision":2751,"compact-revision":-1}
{"level":"info","ts":"2026-03-18T05:49:14.459376Z","caller":"traceutil/trace.go:171","msg":"trace[1688936185] linearizableReadLoop","detail":"{readStateIndex:7903; appliedIndex:7902; }","duration":"196.385828ms","start":"2026-03-18T05:49:14.262947Z","end":"2026-03-18T05:49:14.459333Z","steps":["trace[1688936185] 'read index received'  (duration: 196.144352ms)","trace[1688936185] 'applied index is now lower than readState.Index'  (duration: 240.056µs)"],"step_count":2}
{"level":"info","ts":"2026-03-18T05:49:14.459469Z","caller":"traceutil/trace.go:171","msg":"trace[148024450] transaction","detail":"{read_only:false; response_revision:7621; number_of_response:1; }","duration":"261.866947ms","start":"2026-03-18T05:49:14.197564Z","end":"2026-03-18T05:49:14.45943Z","steps":["trace[148024450] 'process raft request'  (duration: 261.543978ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T05:49:14.459728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.757357ms","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-03-18T05:49:14.45983Z","caller":"traceutil/trace.go:171","msg":"trace[857729264] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:7621; }","duration":"196.903701ms","start":"2026-03-18T05:49:14.262904Z","end":"2026-03-18T05:49:14.459808Z","steps":["trace[857729264] 'agreement among raft nodes before linearized reading'  (duration: 196.612434ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T05:49:14.459854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.157274ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/shovels/\" range_end:\"/registry/rabbitmq.com/shovels0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-18T05:49:14.459852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.741042ms","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-03-18T05:49:14.459923Z","caller":"traceutil/trace.go:171","msg":"trace[1460310559] range","detail":"{range_begin:/registry/rabbitmq.com/shovels/; range_end:/registry/rabbitmq.com/shovels0; response_count:0; response_revision:7621; }","duration":"191.299497ms","start":"2026-03-18T05:49:14.268605Z","end":"2026-03-18T05:49:14.459904Z","steps":["trace[1460310559] 'agreement among raft nodes before linearized reading'  (duration: 191.118943ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T05:49:14.459933Z","caller":"traceutil/trace.go:171","msg":"trace[1032882271] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:7621; }","duration":"195.894826ms","start":"2026-03-18T05:49:14.26402Z","end":"2026-03-18T05:49:14.459915Z","steps":["trace[1032882271] 'agreement among raft nodes before linearized reading'  (duration: 195.603819ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T05:49:14.459988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.17514ms","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-03-18T05:49:14.46005Z","caller":"traceutil/trace.go:171","msg":"trace[1500858217] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:7621; }","duration":"193.266793ms","start":"2026-03-18T05:49:14.266769Z","end":"2026-03-18T05:49:14.460036Z","steps":["trace[1500858217] 'agreement among raft nodes before linearized reading'  (duration: 193.056358ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T05:49:14.460026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.556775ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:559"}
{"level":"info","ts":"2026-03-18T05:49:14.460211Z","caller":"traceutil/trace.go:171","msg":"trace[669373341] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:7621; }","duration":"100.78642ms","start":"2026-03-18T05:49:14.359394Z","end":"2026-03-18T05:49:14.46018Z","steps":["trace[669373341] 'agreement among raft nodes before linearized reading'  (duration: 100.284248ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T05:49:14.592603Z","caller":"traceutil/trace.go:171","msg":"trace[148322997] transaction","detail":"{read_only:false; response_revision:7622; number_of_response:1; }","duration":"127.366753ms","start":"2026-03-18T05:49:14.465201Z","end":"2026-03-18T05:49:14.592568Z","steps":["trace[148322997] 'process raft request'  (duration: 126.871091ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T05:49:14.593049Z","caller":"traceutil/trace.go:171","msg":"trace[1083135873] transaction","detail":"{read_only:false; response_revision:7623; number_of_response:1; }","duration":"123.421779ms","start":"2026-03-18T05:49:14.469587Z","end":"2026-03-18T05:49:14.593009Z","steps":["trace[1083135873] 'process raft request'  (duration: 123.181794ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T05:49:14.593304Z","caller":"traceutil/trace.go:171","msg":"trace[392059235] transaction","detail":"{read_only:false; response_revision:7624; number_of_response:1; }","duration":"123.683165ms","start":"2026-03-18T05:49:14.469591Z","end":"2026-03-18T05:49:14.593275Z","steps":["trace[392059235] 'process raft request'  (duration: 123.359338ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T05:49:14.593301Z","caller":"traceutil/trace.go:171","msg":"trace[500855049] transaction","detail":"{read_only:false; response_revision:7625; number_of_response:1; }","duration":"123.617565ms","start":"2026-03-18T05:49:14.46966Z","end":"2026-03-18T05:49:14.593278Z","steps":["trace[500855049] 'process raft request'  (duration: 123.505872ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T05:49:26.887993Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.725008ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"}
{"level":"warn","ts":"2026-03-18T05:49:26.888123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.898423ms","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-03-18T05:49:26.888211Z","caller":"traceutil/trace.go:171","msg":"trace[2114219402] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:7678; }","duration":"232.025995ms","start":"2026-03-18T05:49:26.656161Z","end":"2026-03-18T05:49:26.888187Z","steps":["trace[2114219402] 'range keys from in-memory index tree'  (duration: 231.655197ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T05:49:26.888129Z","caller":"traceutil/trace.go:171","msg":"trace[1515613770] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:7678; }","duration":"231.942834ms","start":"2026-03-18T05:49:26.656157Z","end":"2026-03-18T05:49:26.8881Z","steps":["trace[1515613770] 'range keys from in-memory index tree'  (duration: 231.500974ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T05:49:26.889374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.363511ms","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-03-18T05:49:26.889466Z","caller":"traceutil/trace.go:171","msg":"trace[774725654] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:7678; }","duration":"239.505744ms","start":"2026-03-18T05:49:26.649944Z","end":"2026-03-18T05:49:26.889449Z","steps":["trace[774725654] 'range keys from in-memory index tree'  (duration: 238.361576ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T05:49:27.62854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.311066ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13976812589482470282 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:7675 > 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-03-18T05:49:27.628684Z","caller":"traceutil/trace.go:171","msg":"trace[957300972] linearizableReadLoop","detail":"{readStateIndex:7970; appliedIndex:7969; }","duration":"366.169631ms","start":"2026-03-18T05:49:27.262489Z","end":"2026-03-18T05:49:27.628658Z","steps":["trace[957300972] 'read index received'  (duration: 98.574998ms)","trace[957300972] 'applied index is now lower than readState.Index'  (duration: 267.592213ms)"],"step_count":2}
{"level":"info","ts":"2026-03-18T05:49:27.628818Z","caller":"traceutil/trace.go:171","msg":"trace[718610964] transaction","detail":"{read_only:false; response_revision:7684; number_of_response:1; }","duration":"370.215348ms","start":"2026-03-18T05:49:27.258558Z","end":"2026-03-18T05:49:27.628773Z","steps":["trace[718610964] 'process raft request'  (duration: 102.522752ms)","trace[718610964] 'compare'  (duration: 267.025479ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-18T05:49:27.629015Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T05:49:27.258521Z","time spent":"370.397482ms","remote":"127.0.0.1:59612","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:7675 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"warn","ts":"2026-03-18T05:49:27.629196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"366.699523ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-cl7zm\" ","response":"range_response_count:1 size:6531"}
{"level":"info","ts":"2026-03-18T05:49:27.629302Z","caller":"traceutil/trace.go:171","msg":"trace[630233051] range","detail":"{range_begin:/registry/pods/openstack/keepalived-cl7zm; range_end:; response_count:1; response_revision:7684; }","duration":"366.896948ms","start":"2026-03-18T05:49:27.262385Z","end":"2026-03-18T05:49:27.629282Z","steps":["trace[630233051] 'agreement among raft nodes before linearized reading'  (duration: 366.381856ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T05:49:27.629436Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T05:49:27.26235Z","time spent":"367.073502ms","remote":"127.0.0.1:59542","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6555,"request content":"key:\"/registry/pods/openstack/keepalived-cl7zm\" "}
{"level":"info","ts":"2026-03-18T05:49:27.653621Z","caller":"traceutil/trace.go:171","msg":"trace[450468140] transaction","detail":"{read_only:false; response_revision:7685; number_of_response:1; }","duration":"296.689775ms","start":"2026-03-18T05:49:27.356898Z","end":"2026-03-18T05:49:27.653588Z","steps":["trace[450468140] 'process raft request'  (duration: 296.49625ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T05:49:27.691977Z","caller":"traceutil/trace.go:171","msg":"trace[332875851] transaction","detail":"{read_only:false; response_revision:7686; number_of_response:1; }","duration":"330.340187ms","start":"2026-03-18T05:49:27.361617Z","end":"2026-03-18T05:49:27.691958Z","steps":["trace[332875851] 'process raft request'  (duration: 330.150392ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T05:49:27.692085Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T05:49:27.361577Z","time spent":"330.45589ms","remote":"127.0.0.1:59612","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:7676 > 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-03-18T05:49:27.692156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.747523ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-18T05:49:27.692234Z","caller":"traceutil/trace.go:171","msg":"trace[804874798] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:7686; }","duration":"308.901136ms","start":"2026-03-18T05:49:27.383317Z","end":"2026-03-18T05:49:27.692218Z","steps":["trace[804874798] 'agreement among raft nodes before linearized reading'  (duration: 308.742092ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T05:49:27.692283Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T05:49:27.383295Z","time spent":"308.977388ms","remote":"127.0.0.1:59332","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-03-18T05:49:27.919959Z","caller":"traceutil/trace.go:171","msg":"trace[31509265] transaction","detail":"{read_only:false; response_revision:7687; number_of_response:1; }","duration":"108.250238ms","start":"2026-03-18T05:49:27.811683Z","end":"2026-03-18T05:49:27.919933Z","steps":["trace[31509265] 'process raft request'  (duration: 108.084164ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T05:49:36.863612Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5715}
{"level":"info","ts":"2026-03-18T05:49:36.963862Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5715,"took":"97.849461ms","hash":117389945,"current-db-size-bytes":43954176,"current-db-size":"44 MB","current-db-size-in-use-bytes":23244800,"current-db-size-in-use":"23 MB"}
{"level":"info","ts":"2026-03-18T05:49:36.963924Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":117389945,"revision":5715,"compact-revision":2751}
{"level":"warn","ts":"2026-03-18T05:49:55.214156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.199379ms","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-03-18T05:49:55.21424Z","caller":"traceutil/trace.go:171","msg":"trace[1533405293] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:7872; }","duration":"166.366103ms","start":"2026-03-18T05:49:55.047861Z","end":"2026-03-18T05:49:55.214228Z","steps":["trace[1533405293] 'agreement among raft nodes before linearized reading'  (duration: 166.081566ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T05:49:55.213899Z","caller":"traceutil/trace.go:171","msg":"trace[463721876] linearizableReadLoop","detail":"{readStateIndex:8167; appliedIndex:8166; }","duration":"165.877561ms","start":"2026-03-18T05:49:55.047935Z","end":"2026-03-18T05:49:55.213812Z","steps":["trace[463721876] 'read index received'  (duration: 159.904838ms)","trace[463721876] 'applied index is now lower than readState.Index'  (duration: 5.971323ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-18T05:49:55.214806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.791173ms","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-03-18T05:49:55.214846Z","caller":"traceutil/trace.go:171","msg":"trace[1669513785] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:7872; }","duration":"166.879665ms","start":"2026-03-18T05:49:55.047957Z","end":"2026-03-18T05:49:55.214836Z","steps":["trace[1669513785] 'agreement among raft nodes before linearized reading'  (duration: 166.774882ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T05:49:55.215059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.184561ms","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-03-18T05:49:55.215106Z","caller":"traceutil/trace.go:171","msg":"trace[1891318698] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:7872; }","duration":"164.288753ms","start":"2026-03-18T05:49:55.050805Z","end":"2026-03-18T05:49:55.215093Z","steps":["trace[1891318698] 'agreement among raft nodes before linearized reading'  (duration: 163.948705ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T05:50:00.047476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.456034ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"}
{"level":"info","ts":"2026-03-18T05:50:00.047561Z","caller":"traceutil/trace.go:171","msg":"trace[930666332] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:7895; }","duration":"292.610988ms","start":"2026-03-18T05:49:59.754934Z","end":"2026-03-18T05:50:00.047545Z","steps":["trace[930666332] 'range keys from in-memory index tree'  (duration: 292.281571ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T05:50:00.102161Z","caller":"traceutil/trace.go:171","msg":"trace[1132694156] transaction","detail":"{read_only:false; response_revision:7896; number_of_response:1; }","duration":"299.661896ms","start":"2026-03-18T05:49:59.802462Z","end":"2026-03-18T05:50:00.102124Z","steps":["trace[1132694156] 'process raft request'  (duration: 299.515673ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T05:50:00.114842Z","caller":"traceutil/trace.go:171","msg":"trace[1345914002] transaction","detail":"{read_only:false; response_revision:7897; number_of_response:1; }","duration":"309.287755ms","start":"2026-03-18T05:49:59.805535Z","end":"2026-03-18T05:50:00.114822Z","steps":["trace[1345914002] 'process raft request'  (duration: 309.136152ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T05:50:00.115005Z","caller":"traceutil/trace.go:171","msg":"trace[1730102014] linearizableReadLoop","detail":"{readStateIndex:8192; appliedIndex:8190; }","duration":"223.522614ms","start":"2026-03-18T05:49:59.891443Z","end":"2026-03-18T05:50:00.114966Z","steps":["trace[1730102014] 'read index received'  (duration: 210.652748ms)","trace[1730102014] 'applied index is now lower than readState.Index'  (duration: 12.866706ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-18T05:50:00.115222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.771369ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-cl7zm\" ","response":"range_response_count:1 size:6531"}
{"level":"info","ts":"2026-03-18T05:50:00.115291Z","caller":"traceutil/trace.go:171","msg":"trace[1489869994] range","detail":"{range_begin:/registry/pods/openstack/keepalived-cl7zm; range_end:; response_count:1; response_revision:7898; }","duration":"223.898723ms","start":"2026-03-18T05:49:59.891373Z","end":"2026-03-18T05:50:00.115272Z","steps":["trace[1489869994] 'agreement among raft nodes before linearized reading'  (duration: 223.699398ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T05:50:00.115347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.55502ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.204\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-03-18T05:50:00.115418Z","caller":"traceutil/trace.go:171","msg":"trace[1361205958] range","detail":"{range_begin:/registry/masterleases/162.253.55.204; range_end:; response_count:1; response_revision:7898; }","duration":"193.689833ms","start":"2026-03-18T05:49:59.921706Z","end":"2026-03-18T05:50:00.115396Z","steps":["trace[1361205958] 'agreement among raft nodes before linearized reading'  (duration: 193.462277ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T05:50:00.115505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.713346ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-18T05:50:00.115554Z","caller":"traceutil/trace.go:171","msg":"trace[602653713] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:7898; }","duration":"144.810178ms","start":"2026-03-18T05:49:59.970732Z","end":"2026-03-18T05:50:00.115543Z","steps":["trace[602653713] 'agreement among raft nodes before linearized reading'  (duration: 144.741686ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T05:50:00.115743Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T05:49:59.805517Z","time spent":"309.387317ms","remote":"127.0.0.1:59612","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:7887 > 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-03-18T05:50:08.602337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.666012ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13976812589482471215 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/openstack/rook-ceph-detect-version-zxvxw.189dd9886840314c\" mod_revision:0 > success:<request_put:<key:\"/registry/events/openstack/rook-ceph-detect-version-zxvxw.189dd9886840314c\" value_size:654 lease:4753440552627694287 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-03-18T05:50:08.602582Z","caller":"traceutil/trace.go:171","msg":"trace[340299768] linearizableReadLoop","detail":"{readStateIndex:8281; appliedIndex:8279; }","duration":"431.049226ms","start":"2026-03-18T05:50:08.171508Z","end":"2026-03-18T05:50:08.602557Z","steps":["trace[340299768] 'read index received'  (duration: 258.083556ms)","trace[340299768] 'applied index is now lower than readState.Index'  (duration: 172.96427ms)"],"step_count":2}
{"level":"info","ts":"2026-03-18T05:50:08.602807Z","caller":"traceutil/trace.go:171","msg":"trace[47322661] transaction","detail":"{read_only:false; response_revision:7980; number_of_response:1; }","duration":"458.801287ms","start":"2026-03-18T05:50:08.143989Z","end":"2026-03-18T05:50:08.60279Z","steps":["trace[47322661] 'process raft request'  (duration: 285.586232ms)","trace[47322661] 'compare'  (duration: 172.515809ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-18T05:50:08.602899Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T05:50:08.143973Z","time spent":"458.895879ms","remote":"127.0.0.1:59416","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":746,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/events/openstack/rook-ceph-detect-version-zxvxw.189dd9886840314c\" mod_revision:0 > success:<request_put:<key:\"/registry/events/openstack/rook-ceph-detect-version-zxvxw.189dd9886840314c\" value_size:654 lease:4753440552627694287 >> failure:<>"}
{"level":"info","ts":"2026-03-18T05:50:08.603354Z","caller":"traceutil/trace.go:171","msg":"trace[1676943384] transaction","detail":"{read_only:false; response_revision:7981; number_of_response:1; }","duration":"454.030313ms","start":"2026-03-18T05:50:08.149304Z","end":"2026-03-18T05:50:08.603334Z","steps":["trace[1676943384] 'process raft request'  (duration: 453.160592ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T05:50:08.603476Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T05:50:08.149288Z","time spent":"454.121535ms","remote":"127.0.0.1:59542","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4638,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/pods/openstack/rook-ceph-detect-version-zxvxw\" mod_revision:7977 > success:<request_put:<key:\"/registry/pods/openstack/rook-ceph-detect-version-zxvxw\" value_size:4575 >> failure:<request_range:<key:\"/registry/pods/openstack/rook-ceph-detect-version-zxvxw\" > >"}
{"level":"warn","ts":"2026-03-18T05:50:08.603708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"432.209192ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-03-18T05:50:08.603747Z","caller":"traceutil/trace.go:171","msg":"trace[1916039922] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:7981; }","duration":"432.286934ms","start":"2026-03-18T05:50:08.17145Z","end":"2026-03-18T05:50:08.603737Z","steps":["trace[1916039922] 'agreement among raft nodes before linearized reading'  (duration: 432.155041ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T05:50:08.603778Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T05:50:08.171428Z","time spent":"432.343146ms","remote":"127.0.0.1:59612","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-03-18T05:50:09.106226Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.726689ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13976812589482471217 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:7889 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-18T05:50:09.106371Z","caller":"traceutil/trace.go:171","msg":"trace[1427711640] linearizableReadLoop","detail":"{readStateIndex:8282; appliedIndex:8281; }","duration":"503.717207ms","start":"2026-03-18T05:50:08.602632Z","end":"2026-03-18T05:50:09.106349Z","steps":["trace[1427711640] 'read index received'  (duration: 397.796004ms)","trace[1427711640] 'applied index is now lower than readState.Index'  (duration: 105.919513ms)"],"step_count":2}
{"level":"info","ts":"2026-03-18T05:50:09.106503Z","caller":"traceutil/trace.go:171","msg":"trace[261087334] transaction","detail":"{read_only:false; response_revision:7982; number_of_response:1; }","duration":"707.435948ms","start":"2026-03-18T05:50:08.399048Z","end":"2026-03-18T05:50:09.106484Z","steps":["trace[261087334] 'process raft request'  (duration: 601.319591ms)","trace[261087334] 'compare'  (duration: 105.486003ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-18T05:50:09.106631Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T05:50:08.399022Z","time spent":"707.530961ms","remote":"127.0.0.1:59612","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:7889 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"warn","ts":"2026-03-18T05:50:09.106729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"722.927517ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-18T05:50:09.106844Z","caller":"traceutil/trace.go:171","msg":"trace[1329329855] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:7982; }","duration":"723.100231ms","start":"2026-03-18T05:50:08.383718Z","end":"2026-03-18T05:50:09.106818Z","steps":["trace[1329329855] 'agreement among raft nodes before linearized reading'  (duration: 722.868846ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T05:50:09.106895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T05:50:08.383688Z","time spent":"723.197723ms","remote":"127.0.0.1:59332","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-03-18T05:50:09.107012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"925.758147ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-cl7zm\" ","response":"range_response_count:1 size:6531"}
{"level":"info","ts":"2026-03-18T05:50:09.107098Z","caller":"traceutil/trace.go:171","msg":"trace[1470243300] range","detail":"{range_begin:/registry/pods/openstack/keepalived-cl7zm; range_end:; response_count:1; response_revision:7982; }","duration":"925.860759ms","start":"2026-03-18T05:50:08.18122Z","end":"2026-03-18T05:50:09.10708Z","steps":["trace[1470243300] 'agreement among raft nodes before linearized reading'  (duration: 925.600993ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T05:50:09.107157Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T05:50:08.181211Z","time spent":"925.933062ms","remote":"127.0.0.1:59542","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6555,"request content":"key:\"/registry/pods/openstack/keepalived-cl7zm\" "}
{"level":"info","ts":"2026-03-18T05:50:09.112964Z","caller":"traceutil/trace.go:171","msg":"trace[973507970] transaction","detail":"{read_only:false; response_revision:7983; number_of_response:1; }","duration":"503.528733ms","start":"2026-03-18T05:50:08.609401Z","end":"2026-03-18T05:50:09.11293Z","steps":["trace[973507970] 'process raft request'  (duration: 503.307398ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T05:50:09.113139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"426.100868ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-18T05:50:09.113143Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T05:50:08.609372Z","time spent":"503.672975ms","remote":"127.0.0.1:59612","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:7957 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:367 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-03-18T05:50:09.113201Z","caller":"traceutil/trace.go:171","msg":"trace[859740604] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:7984; }","duration":"426.212061ms","start":"2026-03-18T05:50:08.686974Z","end":"2026-03-18T05:50:09.113186Z","steps":["trace[859740604] 'agreement among raft nodes before linearized reading'  (duration: 426.116398ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T05:50:09.113244Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T05:50:08.68695Z","time spent":"426.283882ms","remote":"127.0.0.1:59762","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":29,"request content":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true "}
{"level":"info","ts":"2026-03-18T05:50:09.113135Z","caller":"traceutil/trace.go:171","msg":"trace[375599747] transaction","detail":"{read_only:false; response_revision:7984; number_of_response:1; }","duration":"182.081107ms","start":"2026-03-18T05:50:08.931023Z","end":"2026-03-18T05:50:09.113104Z","steps":["trace[375599747] 'process raft request'  (duration: 181.835581ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T05:50:09.113176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.703498ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"warn","ts":"2026-03-18T05:50:09.113279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.178443ms","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-03-18T05:50:09.113406Z","caller":"traceutil/trace.go:171","msg":"trace[785339561] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:7984; }","duration":"259.352166ms","start":"2026-03-18T05:50:08.854026Z","end":"2026-03-18T05:50:09.113378Z","steps":["trace[785339561] 'agreement among raft nodes before linearized reading'  (duration: 259.021898ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T05:50:09.113379Z","caller":"traceutil/trace.go:171","msg":"trace[1142089198] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:7984; }","duration":"239.998605ms","start":"2026-03-18T05:50:08.873348Z","end":"2026-03-18T05:50:09.113347Z","steps":["trace[1142089198] 'agreement among raft nodes before linearized reading'  (duration: 239.591976ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T05:50:09.113535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.401572ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclusters/openstack/ceph\" ","response":"range_response_count:1 size:5732"}
{"level":"info","ts":"2026-03-18T05:50:09.113671Z","caller":"traceutil/trace.go:171","msg":"trace[1034781928] range","detail":"{range_begin:/registry/ceph.rook.io/cephclusters/openstack/ceph; range_end:; response_count:1; response_revision:7984; }","duration":"276.658838ms","start":"2026-03-18T05:50:08.836984Z","end":"2026-03-18T05:50:09.113643Z","steps":["trace[1034781928] 'agreement among raft nodes before linearized reading'  (duration: 276.002083ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T05:50:09.619124Z","caller":"traceutil/trace.go:171","msg":"trace[218538166] linearizableReadLoop","detail":"{readStateIndex:8289; appliedIndex:8288; }","duration":"251.986751ms","start":"2026-03-18T05:50:09.3671Z","end":"2026-03-18T05:50:09.619087Z","steps":["trace[218538166] 'read index received'  (duration: 87.631957ms)","trace[218538166] 'applied index is now lower than readState.Index'  (duration: 164.350184ms)"],"step_count":2}
{"level":"info","ts":"2026-03-18T05:50:09.619223Z","caller":"traceutil/trace.go:171","msg":"trace[2128241857] transaction","detail":"{read_only:false; response_revision:7990; number_of_response:1; }","duration":"167.50708ms","start":"2026-03-18T05:50:09.451684Z","end":"2026-03-18T05:50:09.619191Z","steps":["trace[2128241857] 'process raft request'  (duration: 167.350746ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T05:50:09.619219Z","caller":"traceutil/trace.go:171","msg":"trace[2039487866] transaction","detail":"{read_only:false; response_revision:7989; number_of_response:1; }","duration":"262.229545ms","start":"2026-03-18T05:50:09.356944Z","end":"2026-03-18T05:50:09.619174Z","steps":["trace[2039487866] 'process raft request'  (duration: 192.680299ms)","trace[2039487866] 'compare'  (duration: 69.29072ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-18T05:50:09.619434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.302749ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"}
{"level":"info","ts":"2026-03-18T05:50:09.619485Z","caller":"traceutil/trace.go:171","msg":"trace[1517573384] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:7990; }","duration":"252.403911ms","start":"2026-03-18T05:50:09.367068Z","end":"2026-03-18T05:50:09.619472Z","steps":["trace[1517573384] 'agreement among raft nodes before linearized reading'  (duration: 252.206597ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T05:50:09.620698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.521633ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:57 size:2210989"}
{"level":"info","ts":"2026-03-18T05:50:09.620782Z","caller":"traceutil/trace.go:171","msg":"trace[1259189731] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:57; response_revision:7990; }","duration":"113.677457ms","start":"2026-03-18T05:50:09.507084Z","end":"2026-03-18T05:50:09.620761Z","steps":["trace[1259189731] 'agreement among raft nodes before linearized reading'  (duration: 112.370286ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T05:50:10.396349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.896983ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-18T05:50:10.396499Z","caller":"traceutil/trace.go:171","msg":"trace[145406227] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:7993; }","duration":"345.125989ms","start":"2026-03-18T05:50:10.051341Z","end":"2026-03-18T05:50:10.396467Z","steps":["trace[145406227] 'count revisions from in-memory index tree'  (duration: 344.773431ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T05:50:10.396491Z","caller":"traceutil/trace.go:171","msg":"trace[1969725448] transaction","detail":"{read_only:false; response_revision:7994; number_of_response:1; }","duration":"248.024416ms","start":"2026-03-18T05:50:10.148432Z","end":"2026-03-18T05:50:10.396456Z","steps":["trace[1969725448] 'process raft request'  (duration: 214.18372ms)","trace[1969725448] 'compare'  (duration: 33.551209ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-18T05:50:10.396576Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T05:50:10.05131Z","time spent":"345.245651ms","remote":"127.0.0.1:59754","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":31,"request content":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true "}
{"level":"info","ts":"2026-03-18T05:50:10.396575Z","caller":"traceutil/trace.go:171","msg":"trace[1393446468] transaction","detail":"{read_only:false; response_revision:7995; number_of_response:1; }","duration":"221.522505ms","start":"2026-03-18T05:50:10.175024Z","end":"2026-03-18T05:50:10.396547Z","steps":["trace[1393446468] 'process raft request'  (duration: 221.362182ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T05:50:22.61125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.789529ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-18T05:50:22.611358Z","caller":"traceutil/trace.go:171","msg":"trace[890225564] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8084; }","duration":"228.945963ms","start":"2026-03-18T05:50:22.38239Z","end":"2026-03-18T05:50:22.611336Z","steps":["trace[890225564] 'range keys from in-memory index tree'  (duration: 228.690697ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T05:50:22.61125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.951961ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/ceph-object-controller-detect-version-xmc8m\" ","response":"range_response_count:1 size:4559"}
{"level":"info","ts":"2026-03-18T05:50:22.611649Z","caller":"traceutil/trace.go:171","msg":"trace[315943336] range","detail":"{range_begin:/registry/pods/openstack/ceph-object-controller-detect-version-xmc8m; range_end:; response_count:1; response_revision:8084; }","duration":"336.391602ms","start":"2026-03-18T05:50:22.275225Z","end":"2026-03-18T05:50:22.611617Z","steps":["trace[315943336] 'range keys from in-memory index tree'  (duration: 335.769887ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T05:50:22.61175Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T05:50:22.275211Z","time spent":"336.501554ms","remote":"127.0.0.1:59542","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":4583,"request content":"key:\"/registry/pods/openstack/ceph-object-controller-detect-version-xmc8m\" "}
{"level":"info","ts":"2026-03-18T05:50:22.612641Z","caller":"traceutil/trace.go:171","msg":"trace[573745589] transaction","detail":"{read_only:false; response_revision:8085; number_of_response:1; }","duration":"168.792029ms","start":"2026-03-18T05:50:22.443795Z","end":"2026-03-18T05:50:22.612587Z","steps":["trace[573745589] 'process raft request'  (duration: 167.671283ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T05:50:22.613196Z","caller":"traceutil/trace.go:171","msg":"trace[589212956] transaction","detail":"{read_only:false; response_revision:8086; number_of_response:1; }","duration":"168.134364ms","start":"2026-03-18T05:50:22.44463Z","end":"2026-03-18T05:50:22.612764Z","steps":["trace[589212956] 'process raft request'  (duration: 167.804337ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T05:51:27.721451Z","caller":"traceutil/trace.go:171","msg":"trace[1388081904] transaction","detail":"{read_only:false; response_revision:8700; number_of_response:1; }","duration":"122.16254ms","start":"2026-03-18T05:51:27.599258Z","end":"2026-03-18T05:51:27.72142Z","steps":["trace[1388081904] 'process raft request'  (duration: 121.902213ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T05:51:27.726761Z","caller":"traceutil/trace.go:171","msg":"trace[981433061] transaction","detail":"{read_only:false; response_revision:8701; number_of_response:1; }","duration":"124.962347ms","start":"2026-03-18T05:51:27.601758Z","end":"2026-03-18T05:51:27.726721Z","steps":["trace[981433061] 'process raft request'  (duration: 124.747812ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T05:51:28.240687Z","caller":"traceutil/trace.go:171","msg":"trace[1282027823] transaction","detail":"{read_only:false; response_revision:8705; number_of_response:1; }","duration":"140.362492ms","start":"2026-03-18T05:51:28.100289Z","end":"2026-03-18T05:51:28.240652Z","steps":["trace[1282027823] 'process raft request'  (duration: 114.188871ms)","trace[1282027823] 'compare'  (duration: 26.029628ms)"],"step_count":2}
{"level":"info","ts":"2026-03-18T05:54:03.151255Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"a11c20306510c1f7","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-03-18T05:54:03.156693Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-03-18T05:54:03.156803Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-03-18T05:54:36.87139Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":7733}
{"level":"info","ts":"2026-03-18T05:54:36.945218Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":7733,"took":"70.080058ms","hash":1391071791,"current-db-size-bytes":43954176,"current-db-size":"44 MB","current-db-size-in-use-bytes":25202688,"current-db-size-in-use":"25 MB"}
{"level":"info","ts":"2026-03-18T05:54:36.945366Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1391071791,"revision":7733,"compact-revision":5715}
{"level":"info","ts":"2026-03-18T05:55:38.818369Z","caller":"traceutil/trace.go:171","msg":"trace[1425269157] transaction","detail":"{read_only:false; response_revision:10201; number_of_response:1; }","duration":"121.787647ms","start":"2026-03-18T05:55:38.696548Z","end":"2026-03-18T05:55:38.818336Z","steps":["trace[1425269157] 'process raft request'  (duration: 118.804276ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T05:55:38.833956Z","caller":"traceutil/trace.go:171","msg":"trace[1696267300] transaction","detail":"{read_only:false; response_revision:10202; number_of_response:1; }","duration":"120.634781ms","start":"2026-03-18T05:55:38.713288Z","end":"2026-03-18T05:55:38.833922Z","steps":["trace[1696267300] 'process raft request'  (duration: 120.421105ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T05:57:48.293165Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976812589482479274,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-03-18T05:57:48.306646Z","caller":"traceutil/trace.go:171","msg":"trace[730895365] linearizableReadLoop","detail":"{readStateIndex:11274; appliedIndex:11273; }","duration":"513.665178ms","start":"2026-03-18T05:57:47.792944Z","end":"2026-03-18T05:57:48.30661Z","steps":["trace[730895365] 'read index received'  (duration: 513.329811ms)","trace[730895365] 'applied index is now lower than readState.Index'  (duration: 333.977µs)"],"step_count":2}
{"level":"info","ts":"2026-03-18T05:57:48.306701Z","caller":"traceutil/trace.go:171","msg":"trace[1339472746] transaction","detail":"{read_only:false; response_revision:10866; number_of_response:1; }","duration":"777.490654ms","start":"2026-03-18T05:57:47.529173Z","end":"2026-03-18T05:57:48.306664Z","steps":["trace[1339472746] 'process raft request'  (duration: 777.205517ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T05:57:48.306896Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T05:57:47.52915Z","time spent":"777.633477ms","remote":"127.0.0.1:59612","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:10856 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-03-18T05:57:48.307048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"502.959933ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"warn","ts":"2026-03-18T05:57:48.30705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"514.093478ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"warn","ts":"2026-03-18T05:57:48.307095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.757943ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"}
{"level":"warn","ts":"2026-03-18T05:57:48.307102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.824271ms","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-03-18T05:57:48.307135Z","caller":"traceutil/trace.go:171","msg":"trace[309182093] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:10866; }","duration":"503.087147ms","start":"2026-03-18T05:57:47.804016Z","end":"2026-03-18T05:57:48.307103Z","steps":["trace[309182093] 'agreement among raft nodes before linearized reading'  (duration: 502.902132ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T05:57:48.30714Z","caller":"traceutil/trace.go:171","msg":"trace[1614065356] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:10866; }","duration":"514.254273ms","start":"2026-03-18T05:57:47.792867Z","end":"2026-03-18T05:57:48.307122Z","steps":["trace[1614065356] 'agreement among raft nodes before linearized reading'  (duration: 513.870062ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T05:57:48.307158Z","caller":"traceutil/trace.go:171","msg":"trace[2131710979] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:10866; }","duration":"350.855626ms","start":"2026-03-18T05:57:47.956288Z","end":"2026-03-18T05:57:48.307144Z","steps":["trace[2131710979] 'agreement among raft nodes before linearized reading'  (duration: 350.65755ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T05:57:48.307162Z","caller":"traceutil/trace.go:171","msg":"trace[287238165] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:10866; }","duration":"254.930634ms","start":"2026-03-18T05:57:48.052218Z","end":"2026-03-18T05:57:48.307149Z","steps":["trace[287238165] 'agreement among raft nodes before linearized reading'  (duration: 254.723848ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T05:57:48.307185Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T05:57:47.803993Z","time spent":"503.18282ms","remote":"127.0.0.1:59612","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-03-18T05:57:48.307196Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T05:57:47.792835Z","time spent":"514.349875ms","remote":"127.0.0.1:59612","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-03-18T05:57:48.307199Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T05:57:47.956266Z","time spent":"350.925668ms","remote":"127.0.0.1:59612","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":463,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-03-18T05:59:36.880032Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":9799}
{"level":"info","ts":"2026-03-18T05:59:36.963259Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":9799,"took":"80.72304ms","hash":836272717,"current-db-size-bytes":43954176,"current-db-size":"44 MB","current-db-size-in-use-bytes":17141760,"current-db-size-in-use":"17 MB"}
{"level":"info","ts":"2026-03-18T05:59:36.963354Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":836272717,"revision":9799,"compact-revision":7733}