{"level":"warn","ts":"2026-05-06T01:11:42.219265Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-05-06T01:11:42.219347Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.82:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.82:2380","--initial-cluster=instance=https://199.19.213.82:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.82:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.82:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]}
{"level":"warn","ts":"2026-05-06T01:11:42.219422Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-05-06T01:11:42.219437Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.82:2380"]}
{"level":"info","ts":"2026-05-06T01:11:42.219453Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-05-06T01:11:42.220235Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.82:2379"]}
{"level":"info","ts":"2026-05-06T01:11:42.22031Z","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":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.82:2380"],"listen-peer-urls":["https://199.19.213.82:2380"],"advertise-client-urls":["https://199.19.213.82:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.82:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.82:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"}
{"level":"info","ts":"2026-05-06T01:11:42.224804Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.313426ms"}
{"level":"info","ts":"2026-05-06T01:11:42.23125Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"5d464d3ed167a141","cluster-id":"2ab4f6fe2538e5aa"}
{"level":"info","ts":"2026-05-06T01:11:42.23134Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5d464d3ed167a141 switched to configuration voters=()"}
{"level":"info","ts":"2026-05-06T01:11:42.231365Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5d464d3ed167a141 became follower at term 0"}
{"level":"info","ts":"2026-05-06T01:11:42.231383Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 5d464d3ed167a141 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-05-06T01:11:42.231393Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5d464d3ed167a141 became follower at term 1"}
{"level":"info","ts":"2026-05-06T01:11:42.231428Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5d464d3ed167a141 switched to configuration voters=(6721144426093584705)"}
{"level":"warn","ts":"2026-05-06T01:11:42.239447Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-05-06T01:11:42.240784Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-05-06T01:11:42.241915Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"}
{"level":"info","ts":"2026-05-06T01:11:42.245465Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"5d464d3ed167a141","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-05-06T01:11:42.246455Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"}
{"level":"info","ts":"2026-05-06T01:11:42.24654Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"}
{"level":"info","ts":"2026-05-06T01:11:42.246552Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"}
{"level":"info","ts":"2026-05-06T01:11:42.253228Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"5d464d3ed167a141","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-05-06T01:11:42.253616Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5d464d3ed167a141 switched to configuration voters=(6721144426093584705)"}
{"level":"info","ts":"2026-05-06T01:11:42.253828Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"2ab4f6fe2538e5aa","local-member-id":"5d464d3ed167a141","added-peer-id":"5d464d3ed167a141","added-peer-peer-urls":["https://199.19.213.82:2380"]}
{"level":"info","ts":"2026-05-06T01:11:42.257034Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-05-06T01:11:42.257362Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.82:2380"}
{"level":"info","ts":"2026-05-06T01:11:42.257386Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.82:2380"}
{"level":"info","ts":"2026-05-06T01:11:42.25798Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"5d464d3ed167a141","initial-advertise-peer-urls":["https://199.19.213.82:2380"],"listen-peer-urls":["https://199.19.213.82:2380"],"advertise-client-urls":["https://199.19.213.82:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.82:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-05-06T01:11:42.258005Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-05-06T01:11:42.731964Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5d464d3ed167a141 is starting a new election at term 1"}
{"level":"info","ts":"2026-05-06T01:11:42.732022Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5d464d3ed167a141 became pre-candidate at term 1"}
{"level":"info","ts":"2026-05-06T01:11:42.732062Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5d464d3ed167a141 received MsgPreVoteResp from 5d464d3ed167a141 at term 1"}
{"level":"info","ts":"2026-05-06T01:11:42.73208Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5d464d3ed167a141 became candidate at term 2"}
{"level":"info","ts":"2026-05-06T01:11:42.73209Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5d464d3ed167a141 received MsgVoteResp from 5d464d3ed167a141 at term 2"}
{"level":"info","ts":"2026-05-06T01:11:42.732106Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5d464d3ed167a141 became leader at term 2"}
{"level":"info","ts":"2026-05-06T01:11:42.732368Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 5d464d3ed167a141 elected leader 5d464d3ed167a141 at term 2"}
{"level":"info","ts":"2026-05-06T01:11:42.733667Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-06T01:11:42.734675Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"5d464d3ed167a141","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.82:2379]}","request-path":"/0/members/5d464d3ed167a141/attributes","cluster-id":"2ab4f6fe2538e5aa","publish-timeout":"7s"}
{"level":"info","ts":"2026-05-06T01:11:42.734732Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-05-06T01:11:42.735246Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-05-06T01:11:42.735569Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"2ab4f6fe2538e5aa","local-member-id":"5d464d3ed167a141","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-06T01:11:42.735791Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-06T01:11:42.735833Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-06T01:11:42.735975Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-05-06T01:11:42.735996Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-05-06T01:11:42.73847Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-05-06T01:11:42.73858Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.82:2379"}
{"level":"info","ts":"2026-05-06T01:11:49.029131Z","caller":"traceutil/trace.go:171","msg":"trace[806453053] transaction","detail":"{read_only:false; response_revision:312; number_of_response:1; }","duration":"110.520497ms","start":"2026-05-06T01:11:48.918581Z","end":"2026-05-06T01:11:49.029102Z","steps":["trace[806453053] 'process raft request'  (duration: 101.384584ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T01:12:11.146551Z","caller":"traceutil/trace.go:171","msg":"trace[1391898592] transaction","detail":"{read_only:false; response_revision:502; number_of_response:1; }","duration":"105.49303ms","start":"2026-05-06T01:12:11.041014Z","end":"2026-05-06T01:12:11.146507Z","steps":["trace[1391898592] 'process raft request'  (duration: 75.025713ms)","trace[1391898592] 'compare'  (duration: 30.286074ms)"],"step_count":2}
{"level":"info","ts":"2026-05-06T01:12:11.163638Z","caller":"traceutil/trace.go:171","msg":"trace[190623725] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"120.346619ms","start":"2026-05-06T01:12:11.043203Z","end":"2026-05-06T01:12:11.163549Z","steps":["trace[190623725] 'process raft request'  (duration: 119.997394ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T01:12:11.163846Z","caller":"traceutil/trace.go:171","msg":"trace[78677936] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"104.891181ms","start":"2026-05-06T01:12:11.058924Z","end":"2026-05-06T01:12:11.163816Z","steps":["trace[78677936] 'process raft request'  (duration: 104.543547ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T01:12:12.931398Z","caller":"traceutil/trace.go:171","msg":"trace[1609611929] linearizableReadLoop","detail":"{readStateIndex:526; appliedIndex:525; }","duration":"315.603516ms","start":"2026-05-06T01:12:12.615771Z","end":"2026-05-06T01:12:12.931374Z","steps":["trace[1609611929] 'read index received'  (duration: 315.391573ms)","trace[1609611929] 'applied index is now lower than readState.Index'  (duration: 210.883µs)"],"step_count":2}
{"level":"info","ts":"2026-05-06T01:12:12.931665Z","caller":"traceutil/trace.go:171","msg":"trace[517625683] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"382.447587ms","start":"2026-05-06T01:12:12.549067Z","end":"2026-05-06T01:12:12.931514Z","steps":["trace[517625683] 'process raft request'  (duration: 382.169843ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T01:12:12.931702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.299267ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-05-06T01:12:12.931843Z","caller":"traceutil/trace.go:171","msg":"trace[986779330] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:508; }","duration":"100.48578ms","start":"2026-05-06T01:12:12.831327Z","end":"2026-05-06T01:12:12.931813Z","steps":["trace[986779330] 'agreement among raft nodes before linearized reading'  (duration: 100.239536ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T01:12:12.932149Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.753678ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-06T01:12:12.932316Z","caller":"traceutil/trace.go:171","msg":"trace[1372708651] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:508; }","duration":"316.527509ms","start":"2026-05-06T01:12:12.615751Z","end":"2026-05-06T01:12:12.932278Z","steps":["trace[1372708651] 'agreement among raft nodes before linearized reading'  (duration: 315.746629ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T01:12:12.93241Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:12:12.615743Z","time spent":"316.62414ms","remote":"127.0.0.1:46448","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-05-06T01:12:12.932628Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:12:12.549047Z","time spent":"382.798011ms","remote":"127.0.0.1:46748","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:470 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-05-06T01:12:13.045033Z","caller":"traceutil/trace.go:171","msg":"trace[1464963174] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"108.309653ms","start":"2026-05-06T01:12:12.936697Z","end":"2026-05-06T01:12:13.045007Z","steps":["trace[1464963174] 'process raft request'  (duration: 106.126694ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T01:12:13.045325Z","caller":"traceutil/trace.go:171","msg":"trace[294595342] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"108.440544ms","start":"2026-05-06T01:12:12.936849Z","end":"2026-05-06T01:12:13.045289Z","steps":["trace[294595342] 'process raft request'  (duration: 108.11158ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T01:12:19.821045Z","caller":"traceutil/trace.go:171","msg":"trace[1171233278] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"252.068769ms","start":"2026-05-06T01:12:19.568954Z","end":"2026-05-06T01:12:19.821022Z","steps":["trace[1171233278] 'process raft request'  (duration: 251.533471ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T01:12:21.233341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.144551717s","expected-duration":"100ms","prefix":"","request":"header:<ID:11619742214270852120 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/pods/kube-system/cilium-k6qkf\" mod_revision:499 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-k6qkf\" value_size:17081 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-k6qkf\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-06T01:12:21.233672Z","caller":"traceutil/trace.go:171","msg":"trace[981548395] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"1.302884852s","start":"2026-05-06T01:12:19.930748Z","end":"2026-05-06T01:12:21.233633Z","steps":["trace[981548395] 'process raft request'  (duration: 157.727306ms)","trace[981548395] 'compare'  (duration: 1.14431611s)"],"step_count":2}
{"level":"warn","ts":"2026-05-06T01:12:21.233845Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:12:19.93073Z","time spent":"1.303026767s","remote":"127.0.0.1:46684","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-k6qkf\" mod_revision:499 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-k6qkf\" value_size:17081 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-k6qkf\" > >"}
{"level":"info","ts":"2026-05-06T01:12:21.234396Z","caller":"traceutil/trace.go:171","msg":"trace[1942094946] linearizableReadLoop","detail":"{readStateIndex:642; appliedIndex:641; }","duration":"1.220724596s","start":"2026-05-06T01:12:20.013631Z","end":"2026-05-06T01:12:21.234356Z","steps":["trace[1942094946] 'read index received'  (duration: 74.782517ms)","trace[1942094946] 'applied index is now lower than readState.Index'  (duration: 1.145939209s)"],"step_count":2}
{"level":"info","ts":"2026-05-06T01:12:21.234488Z","caller":"traceutil/trace.go:171","msg":"trace[280537001] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"930.619011ms","start":"2026-05-06T01:12:20.303847Z","end":"2026-05-06T01:12:21.234466Z","steps":["trace[280537001] 'process raft request'  (duration: 930.004662ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T01:12:21.234612Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:12:20.303818Z","time spent":"930.734833ms","remote":"127.0.0.1:46566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036309,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" mod_revision:618 > success:<request_put:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" value_size:1036225 >> failure:<request_range:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" > >"}
{"level":"warn","ts":"2026-05-06T01:12:21.234675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.221051256s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-05-06T01:12:21.234713Z","caller":"traceutil/trace.go:171","msg":"trace[73524335] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:621; }","duration":"1.221126779s","start":"2026-05-06T01:12:20.013574Z","end":"2026-05-06T01:12:21.234701Z","steps":["trace[73524335] 'agreement among raft nodes before linearized reading'  (duration: 1.220947823s)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T01:12:21.234748Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:12:20.013561Z","time spent":"1.2211795s","remote":"127.0.0.1:46748","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-05-06T01:12:21.234954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"621.419525ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-06T01:12:21.234994Z","caller":"traceutil/trace.go:171","msg":"trace[451085905] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:621; }","duration":"621.486477ms","start":"2026-05-06T01:12:20.613495Z","end":"2026-05-06T01:12:21.234982Z","steps":["trace[451085905] 'agreement among raft nodes before linearized reading'  (duration: 621.434055ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T01:12:21.235021Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:12:20.613475Z","time spent":"621.539878ms","remote":"127.0.0.1:46448","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-05-06T01:12:21.235074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.929767ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-05-06T01:12:21.235133Z","caller":"traceutil/trace.go:171","msg":"trace[729326200] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:621; }","duration":"142.004579ms","start":"2026-05-06T01:12:21.093114Z","end":"2026-05-06T01:12:21.235118Z","steps":["trace[729326200] 'agreement among raft nodes before linearized reading'  (duration: 141.837654ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T01:12:21.241571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.195306ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"info","ts":"2026-05-06T01:12:21.242612Z","caller":"traceutil/trace.go:171","msg":"trace[127449966] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:621; }","duration":"149.544907ms","start":"2026-05-06T01:12:21.093047Z","end":"2026-05-06T01:12:21.242592Z","steps":["trace[127449966] 'agreement among raft nodes before linearized reading'  (duration: 142.180925ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T01:12:21.240639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.747831ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-05-06T01:12:21.24293Z","caller":"traceutil/trace.go:171","msg":"trace[94048862] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:621; }","duration":"275.156013ms","start":"2026-05-06T01:12:20.967764Z","end":"2026-05-06T01:12:21.24292Z","steps":["trace[94048862] 'agreement among raft nodes before linearized reading'  (duration: 267.512153ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T01:12:37.840319Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11619742214270852500,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-05-06T01:12:37.843073Z","caller":"traceutil/trace.go:171","msg":"trace[958196293] transaction","detail":"{read_only:false; response_revision:787; number_of_response:1; }","duration":"517.887919ms","start":"2026-05-06T01:12:37.325162Z","end":"2026-05-06T01:12:37.84305Z","steps":["trace[958196293] 'process raft request'  (duration: 517.748996ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T01:12:37.843261Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:12:37.325142Z","time spent":"517.987771ms","remote":"127.0.0.1:46748","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:771 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-05-06T01:12:37.858478Z","caller":"traceutil/trace.go:171","msg":"trace[1693834459] linearizableReadLoop","detail":"{readStateIndex:815; appliedIndex:814; }","duration":"519.297966ms","start":"2026-05-06T01:12:37.339171Z","end":"2026-05-06T01:12:37.858469Z","steps":["trace[1693834459] 'read index received'  (duration: 504.169085ms)","trace[1693834459] 'applied index is now lower than readState.Index'  (duration: 15.128321ms)"],"step_count":2}
{"level":"info","ts":"2026-05-06T01:12:37.858573Z","caller":"traceutil/trace.go:171","msg":"trace[132895020] transaction","detail":"{read_only:false; response_revision:788; number_of_response:1; }","duration":"530.710669ms","start":"2026-05-06T01:12:37.327829Z","end":"2026-05-06T01:12:37.85854Z","steps":["trace[132895020] 'process raft request'  (duration: 530.586516ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T01:12:37.858669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"519.47381ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"warn","ts":"2026-05-06T01:12:37.85866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"518.749722ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-05-06T01:12:37.858692Z","caller":"traceutil/trace.go:171","msg":"trace[2131896940] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:788; }","duration":"519.533142ms","start":"2026-05-06T01:12:37.339151Z","end":"2026-05-06T01:12:37.858685Z","steps":["trace[2131896940] 'agreement among raft nodes before linearized reading'  (duration: 519.376667ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T01:12:37.858708Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:12:37.339143Z","time spent":"519.561172ms","remote":"127.0.0.1:46748","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-05-06T01:12:37.858706Z","caller":"traceutil/trace.go:171","msg":"trace[1556888832] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:788; }","duration":"518.795423ms","start":"2026-05-06T01:12:37.339895Z","end":"2026-05-06T01:12:37.858691Z","steps":["trace[1556888832] 'agreement among raft nodes before linearized reading'  (duration: 518.67538ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T01:12:37.858737Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:12:37.339844Z","time spent":"518.885465ms","remote":"127.0.0.1:46748","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-05-06T01:12:37.858733Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:12:37.327805Z","time spent":"530.847102ms","remote":"127.0.0.1:46748","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:772 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-05-06T01:13:30.538748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.965625ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-05-06T01:13:30.539564Z","caller":"traceutil/trace.go:171","msg":"trace[866835902] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:1454; }","duration":"131.832023ms","start":"2026-05-06T01:13:30.407719Z","end":"2026-05-06T01:13:30.539551Z","steps":["trace[866835902] 'count revisions from in-memory index tree'  (duration: 130.889773ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T01:13:32.311563Z","caller":"traceutil/trace.go:171","msg":"trace[634180239] linearizableReadLoop","detail":"{readStateIndex:1506; appliedIndex:1505; }","duration":"163.810711ms","start":"2026-05-06T01:13:32.147739Z","end":"2026-05-06T01:13:32.31155Z","steps":["trace[634180239] 'read index received'  (duration: 163.696829ms)","trace[634180239] 'applied index is now lower than readState.Index'  (duration: 113.352µs)"],"step_count":2}
{"level":"info","ts":"2026-05-06T01:13:32.31163Z","caller":"traceutil/trace.go:171","msg":"trace[1784468485] transaction","detail":"{read_only:false; response_revision:1461; number_of_response:1; }","duration":"316.129782ms","start":"2026-05-06T01:13:31.995495Z","end":"2026-05-06T01:13:32.311625Z","steps":["trace[1784468485] 'process raft request'  (duration: 315.980699ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T01:13:32.311687Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:13:31.995467Z","time spent":"316.178523ms","remote":"127.0.0.1:46548","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":754,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/events/ingress-nginx/ingress-nginx-controller-spjts.18acd4e020cd3036\" mod_revision:0 > success:<request_put:<key:\"/registry/events/ingress-nginx/ingress-nginx-controller-spjts.18acd4e020cd3036\" value_size:658 lease:2396370177416076871 >> failure:<>"}
{"level":"warn","ts":"2026-05-06T01:13:32.311887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.144169ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"info","ts":"2026-05-06T01:13:32.311907Z","caller":"traceutil/trace.go:171","msg":"trace[339745997] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1461; }","duration":"164.212519ms","start":"2026-05-06T01:13:32.14769Z","end":"2026-05-06T01:13:32.311902Z","steps":["trace[339745997] 'agreement among raft nodes before linearized reading'  (duration: 164.128988ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T01:13:32.312001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.71727ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-05-06T01:13:32.312013Z","caller":"traceutil/trace.go:171","msg":"trace[1523689216] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1461; }","duration":"163.73771ms","start":"2026-05-06T01:13:32.148272Z","end":"2026-05-06T01:13:32.312009Z","steps":["trace[1523689216] 'agreement among raft nodes before linearized reading'  (duration: 163.70233ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T01:13:54.791802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.300484ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"warn","ts":"2026-05-06T01:13:54.792076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.655623ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"warn","ts":"2026-05-06T01:13:54.792137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.381866ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-05-06T01:13:54.792206Z","caller":"traceutil/trace.go:171","msg":"trace[495834187] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1850; }","duration":"354.835576ms","start":"2026-05-06T01:13:54.437344Z","end":"2026-05-06T01:13:54.792179Z","steps":["trace[495834187] 'range keys from in-memory index tree'  (duration: 354.399779ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T01:13:54.792106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.94793ms","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-05-06T01:13:54.792276Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:13:54.437322Z","time spent":"354.937708ms","remote":"127.0.0.1:46748","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-05-06T01:13:54.792238Z","caller":"traceutil/trace.go:171","msg":"trace[813404457] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1850; }","duration":"350.524129ms","start":"2026-05-06T01:13:54.441685Z","end":"2026-05-06T01:13:54.792209Z","steps":["trace[813404457] 'range keys from in-memory index tree'  (duration: 350.152492ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T01:13:54.792294Z","caller":"traceutil/trace.go:171","msg":"trace[425454038] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1850; }","duration":"354.158754ms","start":"2026-05-06T01:13:54.438112Z","end":"2026-05-06T01:13:54.792271Z","steps":["trace[425454038] 'range keys from in-memory index tree'  (duration: 353.706285ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T01:13:54.792338Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:13:54.441668Z","time spent":"350.655561ms","remote":"127.0.0.1:46748","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-05-06T01:13:54.792344Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:13:54.438096Z","time spent":"354.233975ms","remote":"127.0.0.1:46748","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-05-06T01:13:54.792545Z","caller":"traceutil/trace.go:171","msg":"trace[782520060] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1850; }","duration":"346.707391ms","start":"2026-05-06T01:13:54.445444Z","end":"2026-05-06T01:13:54.792152Z","steps":["trace[782520060] 'range keys from in-memory index tree'  (duration: 346.130761ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T01:13:54.792802Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:13:54.445408Z","time spent":"347.372153ms","remote":"127.0.0.1:46748","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-05-06T01:13:54.793106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"349.793955ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-9bed2789-70b7-458e-b819-7b183d691a10\" ","response":"range_response_count:1 size:3626"}
{"level":"info","ts":"2026-05-06T01:13:54.793238Z","caller":"traceutil/trace.go:171","msg":"trace[1621535980] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-9bed2789-70b7-458e-b819-7b183d691a10; range_end:; response_count:1; response_revision:1850; }","duration":"349.964687ms","start":"2026-05-06T01:13:54.443258Z","end":"2026-05-06T01:13:54.793222Z","steps":["trace[1621535980] 'range keys from in-memory index tree'  (duration: 348.248567ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T01:13:54.793278Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:13:54.443249Z","time spent":"350.016309ms","remote":"127.0.0.1:46684","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3648,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-9bed2789-70b7-458e-b819-7b183d691a10\" "}
{"level":"info","ts":"2026-05-06T01:13:54.797076Z","caller":"traceutil/trace.go:171","msg":"trace[517899493] transaction","detail":"{read_only:false; response_revision:1851; number_of_response:1; }","duration":"327.424915ms","start":"2026-05-06T01:13:54.469635Z","end":"2026-05-06T01:13:54.79706Z","steps":["trace[517899493] 'process raft request'  (duration: 327.288252ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T01:13:54.797182Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:13:54.469611Z","time spent":"327.509557ms","remote":"127.0.0.1:46748","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:1784 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-05-06T01:13:54.799271Z","caller":"traceutil/trace.go:171","msg":"trace[842783453] linearizableReadLoop","detail":"{readStateIndex:1923; appliedIndex:1923; }","duration":"184.992643ms","start":"2026-05-06T01:13:54.614253Z","end":"2026-05-06T01:13:54.799246Z","steps":["trace[842783453] 'read index received'  (duration: 184.974473ms)","trace[842783453] 'applied index is now lower than readState.Index'  (duration: 16.2µs)"],"step_count":2}
{"level":"warn","ts":"2026-05-06T01:13:54.799379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.128446ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-06T01:13:54.799425Z","caller":"traceutil/trace.go:171","msg":"trace[350530030] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1851; }","duration":"185.220487ms","start":"2026-05-06T01:13:54.614193Z","end":"2026-05-06T01:13:54.799413Z","steps":["trace[350530030] 'agreement among raft nodes before linearized reading'  (duration: 185.143996ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T01:13:54.932185Z","caller":"traceutil/trace.go:171","msg":"trace[1560486045] transaction","detail":"{read_only:false; response_revision:1854; number_of_response:1; }","duration":"134.186444ms","start":"2026-05-06T01:13:54.797973Z","end":"2026-05-06T01:13:54.932159Z","steps":["trace[1560486045] 'process raft request'  (duration: 134.074952ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T01:13:54.932595Z","caller":"traceutil/trace.go:171","msg":"trace[1337593149] transaction","detail":"{read_only:false; response_revision:1855; number_of_response:1; }","duration":"134.55699ms","start":"2026-05-06T01:13:54.798026Z","end":"2026-05-06T01:13:54.932583Z","steps":["trace[1337593149] 'process raft request'  (duration: 134.085542ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T01:13:54.932918Z","caller":"traceutil/trace.go:171","msg":"trace[830520582] linearizableReadLoop","detail":"{readStateIndex:1928; appliedIndex:1924; }","duration":"133.562882ms","start":"2026-05-06T01:13:54.799335Z","end":"2026-05-06T01:13:54.932898Z","steps":["trace[830520582] 'read index received'  (duration: 53.61612ms)","trace[830520582] 'applied index is now lower than readState.Index'  (duration: 79.945462ms)"],"step_count":2}
{"level":"info","ts":"2026-05-06T01:13:54.932935Z","caller":"traceutil/trace.go:171","msg":"trace[1166787813] transaction","detail":"{read_only:false; response_revision:1856; number_of_response:1; }","duration":"133.741695ms","start":"2026-05-06T01:13:54.799174Z","end":"2026-05-06T01:13:54.932916Z","steps":["trace[1166787813] 'process raft request'  (duration: 133.328848ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T01:13:54.933062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.516774ms","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-05-06T01:13:54.933105Z","caller":"traceutil/trace.go:171","msg":"trace[378858819] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:1856; }","duration":"137.620525ms","start":"2026-05-06T01:13:54.795474Z","end":"2026-05-06T01:13:54.933094Z","steps":["trace[378858819] 'agreement among raft nodes before linearized reading'  (duration: 137.513243ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T01:13:54.932241Z","caller":"traceutil/trace.go:171","msg":"trace[492226221] transaction","detail":"{read_only:false; response_revision:1853; number_of_response:1; }","duration":"134.322817ms","start":"2026-05-06T01:13:54.797833Z","end":"2026-05-06T01:13:54.932155Z","steps":["trace[492226221] 'process raft request'  (duration: 130.04431ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T01:13:54.935498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.249943ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-06T01:13:54.935557Z","caller":"traceutil/trace.go:171","msg":"trace[951334525] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1857; }","duration":"135.338374ms","start":"2026-05-06T01:13:54.800203Z","end":"2026-05-06T01:13:54.935541Z","steps":["trace[951334525] 'agreement among raft nodes before linearized reading'  (duration: 135.199652ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T01:14:28.84366Z","caller":"traceutil/trace.go:171","msg":"trace[755998383] transaction","detail":"{read_only:false; response_revision:2095; number_of_response:1; }","duration":"222.64541ms","start":"2026-05-06T01:14:28.62099Z","end":"2026-05-06T01:14:28.843635Z","steps":["trace[755998383] 'process raft request'  (duration: 222.465567ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T01:14:29.23553Z","caller":"traceutil/trace.go:171","msg":"trace[437333746] linearizableReadLoop","detail":"{readStateIndex:2178; appliedIndex:2177; }","duration":"155.584075ms","start":"2026-05-06T01:14:29.079911Z","end":"2026-05-06T01:14:29.235495Z","steps":["trace[437333746] 'read index received'  (duration: 140.455628ms)","trace[437333746] 'applied index is now lower than readState.Index'  (duration: 15.126667ms)"],"step_count":2}
{"level":"info","ts":"2026-05-06T01:14:29.235674Z","caller":"traceutil/trace.go:171","msg":"trace[79127934] transaction","detail":"{read_only:false; response_revision:2098; number_of_response:1; }","duration":"174.576147ms","start":"2026-05-06T01:14:29.061082Z","end":"2026-05-06T01:14:29.235658Z","steps":["trace[79127934] 'process raft request'  (duration: 159.333348ms)","trace[79127934] 'compare'  (duration: 14.552658ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-06T01:14:29.235947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.302518ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-05-06T01:14:29.236048Z","caller":"traceutil/trace.go:171","msg":"trace[509248756] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2098; }","duration":"142.41653ms","start":"2026-05-06T01:14:29.093606Z","end":"2026-05-06T01:14:29.236022Z","steps":["trace[509248756] 'agreement among raft nodes before linearized reading'  (duration: 142.180676ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T01:14:29.23612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.132889ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"info","ts":"2026-05-06T01:14:29.236212Z","caller":"traceutil/trace.go:171","msg":"trace[449930672] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2098; }","duration":"141.287092ms","start":"2026-05-06T01:14:29.094906Z","end":"2026-05-06T01:14:29.236193Z","steps":["trace[449930672] 'agreement among raft nodes before linearized reading'  (duration: 141.013467ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T01:14:29.236273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.308956ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"warn","ts":"2026-05-06T01:14:29.236202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.301528ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12379"}
{"level":"info","ts":"2026-05-06T01:14:29.236384Z","caller":"traceutil/trace.go:171","msg":"trace[1439988223] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2098; }","duration":"156.530042ms","start":"2026-05-06T01:14:29.079842Z","end":"2026-05-06T01:14:29.236372Z","steps":["trace[1439988223] 'agreement among raft nodes before linearized reading'  (duration: 156.153535ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T01:14:29.236468Z","caller":"traceutil/trace.go:171","msg":"trace[1820569395] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2098; }","duration":"135.586889ms","start":"2026-05-06T01:14:29.10073Z","end":"2026-05-06T01:14:29.236317Z","steps":["trace[1820569395] 'agreement among raft nodes before linearized reading'  (duration: 135.111901ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T01:14:29.365066Z","caller":"traceutil/trace.go:171","msg":"trace[1322907522] transaction","detail":"{read_only:false; response_revision:2100; number_of_response:1; }","duration":"124.119992ms","start":"2026-05-06T01:14:29.240921Z","end":"2026-05-06T01:14:29.365041Z","steps":["trace[1322907522] 'process raft request'  (duration: 102.294644ms)","trace[1322907522] 'compare'  (duration: 21.564322ms)"],"step_count":2}
{"level":"info","ts":"2026-05-06T01:14:29.365272Z","caller":"traceutil/trace.go:171","msg":"trace[832155514] linearizableReadLoop","detail":"{readStateIndex:2181; appliedIndex:2178; }","duration":"122.466484ms","start":"2026-05-06T01:14:29.242793Z","end":"2026-05-06T01:14:29.36526Z","steps":["trace[832155514] 'read index received'  (duration: 92.166318ms)","trace[832155514] 'applied index is now lower than readState.Index'  (duration: 30.299446ms)"],"step_count":2}
{"level":"info","ts":"2026-05-06T01:14:29.365359Z","caller":"traceutil/trace.go:171","msg":"trace[509477804] transaction","detail":"{read_only:false; response_revision:2101; number_of_response:1; }","duration":"123.848898ms","start":"2026-05-06T01:14:29.241503Z","end":"2026-05-06T01:14:29.365352Z","steps":["trace[509477804] 'process raft request'  (duration: 123.498082ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T01:14:29.365576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.764809ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-06T01:14:29.365605Z","caller":"traceutil/trace.go:171","msg":"trace[208869423] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:2101; }","duration":"122.832831ms","start":"2026-05-06T01:14:29.242764Z","end":"2026-05-06T01:14:29.365597Z","steps":["trace[208869423] 'agreement among raft nodes before linearized reading'  (duration: 122.76453ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T01:14:29.747847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.530179ms","expected-duration":"100ms","prefix":"","request":"header:<ID:11619742214270855144 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:2090 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-06T01:14:29.747948Z","caller":"traceutil/trace.go:171","msg":"trace[2133743812] linearizableReadLoop","detail":"{readStateIndex:2183; appliedIndex:2182; }","duration":"368.825765ms","start":"2026-05-06T01:14:29.379105Z","end":"2026-05-06T01:14:29.74793Z","steps":["trace[2133743812] 'read index received'  (duration: 195.084331ms)","trace[2133743812] 'applied index is now lower than readState.Index'  (duration: 173.739704ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-06T01:14:29.748458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.345413ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"}
{"level":"info","ts":"2026-05-06T01:14:29.748506Z","caller":"traceutil/trace.go:171","msg":"trace[1725966155] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2103; }","duration":"369.424585ms","start":"2026-05-06T01:14:29.379067Z","end":"2026-05-06T01:14:29.748492Z","steps":["trace[1725966155] 'agreement among raft nodes before linearized reading'  (duration: 369.11539ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T01:14:29.748682Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:14:29.379052Z","time spent":"369.560617ms","remote":"127.0.0.1:43656","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5466,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "}
{"level":"info","ts":"2026-05-06T01:14:29.748906Z","caller":"traceutil/trace.go:171","msg":"trace[1291084968] transaction","detail":"{read_only:false; response_revision:2103; number_of_response:1; }","duration":"379.762685ms","start":"2026-05-06T01:14:29.369111Z","end":"2026-05-06T01:14:29.748873Z","steps":["trace[1291084968] 'process raft request'  (duration: 205.096936ms)","trace[1291084968] 'compare'  (duration: 173.359087ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-06T01:14:29.74912Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:14:29.369097Z","time spent":"379.933188ms","remote":"127.0.0.1:46748","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:2090 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-05-06T01:14:30.303027Z","caller":"traceutil/trace.go:171","msg":"trace[154576916] transaction","detail":"{read_only:false; response_revision:2105; number_of_response:1; }","duration":"243.074919ms","start":"2026-05-06T01:14:30.059922Z","end":"2026-05-06T01:14:30.302997Z","steps":["trace[154576916] 'process raft request'  (duration: 241.703637ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T01:15:33.584474Z","caller":"traceutil/trace.go:171","msg":"trace[320917433] transaction","detail":"{read_only:false; response_revision:2546; number_of_response:1; }","duration":"439.144599ms","start":"2026-05-06T01:15:33.145313Z","end":"2026-05-06T01:15:33.584458Z","steps":["trace[320917433] 'process raft request'  (duration: 438.881185ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T01:15:33.584659Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:15:33.145289Z","time spent":"439.272381ms","remote":"127.0.0.1:46748","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:2499 > 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-05-06T01:15:33.584766Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.356224ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-05-06T01:15:33.584793Z","caller":"traceutil/trace.go:171","msg":"trace[967412104] linearizableReadLoop","detail":"{readStateIndex:2641; appliedIndex:2640; }","duration":"183.005499ms","start":"2026-05-06T01:15:33.401394Z","end":"2026-05-06T01:15:33.5844Z","steps":["trace[967412104] 'read index received'  (duration: 182.840077ms)","trace[967412104] 'applied index is now lower than readState.Index'  (duration: 164.402µs)"],"step_count":2}
{"level":"info","ts":"2026-05-06T01:15:33.584849Z","caller":"traceutil/trace.go:171","msg":"trace[288560829] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2546; }","duration":"183.510527ms","start":"2026-05-06T01:15:33.401317Z","end":"2026-05-06T01:15:33.584827Z","steps":["trace[288560829] 'agreement among raft nodes before linearized reading'  (duration: 183.244193ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T01:15:33.58535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.72208ms","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-05-06T01:15:33.585393Z","caller":"traceutil/trace.go:171","msg":"trace[1029227752] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2547; }","duration":"159.779681ms","start":"2026-05-06T01:15:33.4256Z","end":"2026-05-06T01:15:33.585379Z","steps":["trace[1029227752] 'agreement among raft nodes before linearized reading'  (duration: 159.605988ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T01:15:33.585406Z","caller":"traceutil/trace.go:171","msg":"trace[715382535] transaction","detail":"{read_only:false; response_revision:2547; number_of_response:1; }","duration":"104.235336ms","start":"2026-05-06T01:15:33.481149Z","end":"2026-05-06T01:15:33.585385Z","steps":["trace[715382535] 'process raft request'  (duration: 103.971892ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T01:16:06.516916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.736298ms","expected-duration":"100ms","prefix":"","request":"header:<ID:11619742214270856696 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:2717 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-06T01:16:06.517209Z","caller":"traceutil/trace.go:171","msg":"trace[549725819] transaction","detail":"{read_only:false; response_revision:2727; number_of_response:1; }","duration":"627.699327ms","start":"2026-05-06T01:16:05.889474Z","end":"2026-05-06T01:16:06.517173Z","steps":["trace[549725819] 'process raft request'  (duration: 404.625484ms)","trace[549725819] 'compare'  (duration: 222.433594ms)"],"step_count":2}
{"level":"info","ts":"2026-05-06T01:16:06.517244Z","caller":"traceutil/trace.go:171","msg":"trace[1743404503] transaction","detail":"{read_only:false; response_revision:2728; number_of_response:1; }","duration":"626.313288ms","start":"2026-05-06T01:16:05.890908Z","end":"2026-05-06T01:16:06.517221Z","steps":["trace[1743404503] 'process raft request'  (duration: 626.107205ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T01:16:06.517358Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:16:05.890893Z","time spent":"626.395499ms","remote":"127.0.0.1:46748","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:2718 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-05-06T01:16:06.517362Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:16:05.889461Z","time spent":"627.822069ms","remote":"127.0.0.1:46748","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:2717 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-05-06T01:16:06.517665Z","caller":"traceutil/trace.go:171","msg":"trace[1768399509] linearizableReadLoop","detail":"{readStateIndex:2830; appliedIndex:2828; }","duration":"369.439766ms","start":"2026-05-06T01:16:06.148211Z","end":"2026-05-06T01:16:06.517651Z","steps":["trace[1768399509] 'read index received'  (duration: 145.904017ms)","trace[1768399509] 'applied index is now lower than readState.Index'  (duration: 223.534389ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-06T01:16:06.5178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.404066ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-05-06T01:16:06.517841Z","caller":"traceutil/trace.go:171","msg":"trace[1557131793] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:2729; }","duration":"299.489768ms","start":"2026-05-06T01:16:06.218338Z","end":"2026-05-06T01:16:06.517828Z","steps":["trace[1557131793] 'agreement among raft nodes before linearized reading'  (duration: 299.417807ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T01:16:06.517846Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.63793ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.82\" ","response":"range_response_count:1 size:133"}
{"level":"info","ts":"2026-05-06T01:16:06.517884Z","caller":"traceutil/trace.go:171","msg":"trace[1832623736] range","detail":"{range_begin:/registry/masterleases/199.19.213.82; range_end:; response_count:1; response_revision:2729; }","duration":"369.70137ms","start":"2026-05-06T01:16:06.14817Z","end":"2026-05-06T01:16:06.517871Z","steps":["trace[1832623736] 'agreement among raft nodes before linearized reading'  (duration: 369.557648ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T01:16:06.517922Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:16:06.148149Z","time spent":"369.766231ms","remote":"127.0.0.1:46474","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":155,"request content":"key:\"/registry/masterleases/199.19.213.82\" "}
{"level":"warn","ts":"2026-05-06T01:16:06.518372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.771731ms","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-05-06T01:16:06.518414Z","caller":"traceutil/trace.go:171","msg":"trace[1356538223] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2729; }","duration":"212.856812ms","start":"2026-05-06T01:16:06.305546Z","end":"2026-05-06T01:16:06.518403Z","steps":["trace[1356538223] 'agreement among raft nodes before linearized reading'  (duration: 212.594948ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T01:16:06.519241Z","caller":"traceutil/trace.go:171","msg":"trace[2001090388] transaction","detail":"{read_only:false; response_revision:2729; number_of_response:1; }","duration":"158.127597ms","start":"2026-05-06T01:16:06.359579Z","end":"2026-05-06T01:16:06.517707Z","steps":["trace[2001090388] 'process raft request'  (duration: 157.499598ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T01:16:06.628811Z","caller":"traceutil/trace.go:171","msg":"trace[1215443622] transaction","detail":"{read_only:false; response_revision:2730; number_of_response:1; }","duration":"106.180863ms","start":"2026-05-06T01:16:06.522617Z","end":"2026-05-06T01:16:06.628798Z","steps":["trace[1215443622] 'process raft request'  (duration: 96.835545ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T01:18:25.290843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.066497ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/passwords/monitoring/kube-prometheus-stack-prometheus-client-secret\" ","response":"range_response_count:1 size:1225"}
{"level":"info","ts":"2026-05-06T01:18:25.290951Z","caller":"traceutil/trace.go:171","msg":"trace[1927370125] range","detail":"{range_begin:/registry/secretgen.k14s.io/passwords/monitoring/kube-prometheus-stack-prometheus-client-secret; range_end:; response_count:1; response_revision:3545; }","duration":"117.218311ms","start":"2026-05-06T01:18:25.173708Z","end":"2026-05-06T01:18:25.290926Z","steps":["trace[1927370125] 'range keys from in-memory index tree'  (duration: 116.920285ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T01:18:34.425074Z","caller":"traceutil/trace.go:171","msg":"trace[1030805405] transaction","detail":"{read_only:false; response_revision:3596; number_of_response:1; }","duration":"104.774328ms","start":"2026-05-06T01:18:34.32028Z","end":"2026-05-06T01:18:34.425055Z","steps":["trace[1030805405] 'process raft request'  (duration: 70.079351ms)","trace[1030805405] 'compare'  (duration: 34.617575ms)"],"step_count":2}
{"level":"info","ts":"2026-05-06T01:18:36.584281Z","caller":"traceutil/trace.go:171","msg":"trace[1206412387] transaction","detail":"{read_only:false; response_revision:3607; number_of_response:1; }","duration":"169.595811ms","start":"2026-05-06T01:18:36.414662Z","end":"2026-05-06T01:18:36.584258Z","steps":["trace[1206412387] 'process raft request'  (duration: 169.450698ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T01:18:36.58891Z","caller":"traceutil/trace.go:171","msg":"trace[1119648679] transaction","detail":"{read_only:false; response_revision:3608; number_of_response:1; }","duration":"158.485937ms","start":"2026-05-06T01:18:36.430394Z","end":"2026-05-06T01:18:36.58888Z","steps":["trace[1119648679] 'process raft request'  (duration: 158.202841ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T01:18:36.789305Z","caller":"traceutil/trace.go:171","msg":"trace[596333706] linearizableReadLoop","detail":"{readStateIndex:3751; appliedIndex:3750; }","duration":"176.194512ms","start":"2026-05-06T01:18:36.613084Z","end":"2026-05-06T01:18:36.789279Z","steps":["trace[596333706] 'read index received'  (duration: 108.423321ms)","trace[596333706] 'applied index is now lower than readState.Index'  (duration: 67.769931ms)"],"step_count":2}
{"level":"info","ts":"2026-05-06T01:18:36.789383Z","caller":"traceutil/trace.go:171","msg":"trace[1548443287] transaction","detail":"{read_only:false; response_revision:3613; number_of_response:1; }","duration":"178.206877ms","start":"2026-05-06T01:18:36.611127Z","end":"2026-05-06T01:18:36.789334Z","steps":["trace[1548443287] 'process raft request'  (duration: 110.378115ms)","trace[1548443287] 'compare'  (duration: 67.584346ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-06T01:18:36.78953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.898542ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-05-06T01:18:36.789524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.422477ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-06T01:18:36.789574Z","caller":"traceutil/trace.go:171","msg":"trace[680359031] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:3613; }","duration":"115.967913ms","start":"2026-05-06T01:18:36.673596Z","end":"2026-05-06T01:18:36.789564Z","steps":["trace[680359031] 'agreement among raft nodes before linearized reading'  (duration: 115.864311ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T01:18:36.789612Z","caller":"traceutil/trace.go:171","msg":"trace[1450203909] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:3613; }","duration":"176.54891ms","start":"2026-05-06T01:18:36.613041Z","end":"2026-05-06T01:18:36.78959Z","steps":["trace[1450203909] 'agreement among raft nodes before linearized reading'  (duration: 176.353105ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T01:19:02.698722Z","caller":"traceutil/trace.go:171","msg":"trace[1321607891] linearizableReadLoop","detail":"{readStateIndex:3942; appliedIndex:3941; }","duration":"123.65615ms","start":"2026-05-06T01:19:02.575037Z","end":"2026-05-06T01:19:02.698693Z","steps":["trace[1321607891] 'read index received'  (duration: 122.605268ms)","trace[1321607891] 'applied index is now lower than readState.Index'  (duration: 1.049902ms)"],"step_count":2}
{"level":"info","ts":"2026-05-06T01:19:02.698789Z","caller":"traceutil/trace.go:171","msg":"trace[1413907916] transaction","detail":"{read_only:false; response_revision:3795; number_of_response:1; }","duration":"132.804339ms","start":"2026-05-06T01:19:02.565947Z","end":"2026-05-06T01:19:02.698752Z","steps":["trace[1413907916] 'process raft request'  (duration: 131.839138ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T01:19:02.698928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.875525ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/prometheuses.monitoring.coreos.com\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-06T01:19:02.699187Z","caller":"traceutil/trace.go:171","msg":"trace[585118815] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/prometheuses.monitoring.coreos.com; range_end:; response_count:0; response_revision:3795; }","duration":"124.196102ms","start":"2026-05-06T01:19:02.574978Z","end":"2026-05-06T01:19:02.699174Z","steps":["trace[585118815] 'agreement among raft nodes before linearized reading'  (duration: 123.878595ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T01:19:02.723818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.39964ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-05-06T01:19:02.72383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.339508ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/permissions/\" range_end:\"/registry/rabbitmq.com/permissions0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-06T01:19:02.723879Z","caller":"traceutil/trace.go:171","msg":"trace[348930315] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:3796; }","duration":"108.514583ms","start":"2026-05-06T01:19:02.615349Z","end":"2026-05-06T01:19:02.723864Z","steps":["trace[348930315] 'agreement among raft nodes before linearized reading'  (duration: 108.37075ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T01:19:02.723904Z","caller":"traceutil/trace.go:171","msg":"trace[976819696] range","detail":"{range_begin:/registry/rabbitmq.com/permissions/; range_end:/registry/rabbitmq.com/permissions0; response_count:0; response_revision:3796; }","duration":"108.455912ms","start":"2026-05-06T01:19:02.615428Z","end":"2026-05-06T01:19:02.723884Z","steps":["trace[976819696] 'agreement among raft nodes before linearized reading'  (duration: 108.272418ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T01:19:03.083984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.622121ms","expected-duration":"100ms","prefix":"","request":"header:<ID:11619742214270859626 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/prometheusagents.monitoring.coreos.com\" mod_revision:3795 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/prometheusagents.monitoring.coreos.com\" value_size:328514 >> failure:<request_range:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/prometheusagents.monitoring.coreos.com\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-06T01:19:03.084093Z","caller":"traceutil/trace.go:171","msg":"trace[13992422] linearizableReadLoop","detail":"{readStateIndex:3947; appliedIndex:3946; }","duration":"190.429844ms","start":"2026-05-06T01:19:02.893645Z","end":"2026-05-06T01:19:03.084075Z","steps":["trace[13992422] 'read index received'  (duration: 52.398525ms)","trace[13992422] 'applied index is now lower than readState.Index'  (duration: 138.030099ms)"],"step_count":2}
{"level":"info","ts":"2026-05-06T01:19:03.084207Z","caller":"traceutil/trace.go:171","msg":"trace[1804944478] transaction","detail":"{read_only:false; response_revision:3800; number_of_response:1; }","duration":"279.157059ms","start":"2026-05-06T01:19:02.804992Z","end":"2026-05-06T01:19:03.084149Z","steps":["trace[1804944478] 'process raft request'  (duration: 141.283503ms)","trace[1804944478] 'compare'  (duration: 137.230121ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-06T01:19:03.084257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.577138ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/prometheusrules.monitoring.coreos.com\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-06T01:19:03.084308Z","caller":"traceutil/trace.go:171","msg":"trace[461103542] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/prometheusrules.monitoring.coreos.com; range_end:; response_count:0; response_revision:3800; }","duration":"190.67872ms","start":"2026-05-06T01:19:02.893616Z","end":"2026-05-06T01:19:03.084295Z","steps":["trace[461103542] 'agreement among raft nodes before linearized reading'  (duration: 190.573287ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T01:19:03.135281Z","caller":"traceutil/trace.go:171","msg":"trace[649194157] transaction","detail":"{read_only:false; response_revision:3801; number_of_response:1; }","duration":"151.417356ms","start":"2026-05-06T01:19:02.983813Z","end":"2026-05-06T01:19:03.13523Z","steps":["trace[649194157] 'process raft request'  (duration: 150.168949ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T01:19:03.135355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.963219ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-05-06T01:19:03.135416Z","caller":"traceutil/trace.go:171","msg":"trace[126357961] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/; range_end:/registry/apiregistration.k8s.io/apiservices0; response_count:0; response_revision:3801; }","duration":"164.075761ms","start":"2026-05-06T01:19:02.971322Z","end":"2026-05-06T01:19:03.135398Z","steps":["trace[126357961] 'agreement among raft nodes before linearized reading'  (duration: 163.847476ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T01:19:03.275841Z","caller":"traceutil/trace.go:171","msg":"trace[803705170] linearizableReadLoop","detail":"{readStateIndex:3949; appliedIndex:3948; }","duration":"125.597737ms","start":"2026-05-06T01:19:03.150226Z","end":"2026-05-06T01:19:03.275824Z","steps":["trace[803705170] 'read index received'  (duration: 34.275511ms)","trace[803705170] 'applied index is now lower than readState.Index'  (duration: 91.321436ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-06T01:19:03.276046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.804722ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12209"}
{"level":"info","ts":"2026-05-06T01:19:03.276075Z","caller":"traceutil/trace.go:171","msg":"trace[1818049887] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:3802; }","duration":"125.875473ms","start":"2026-05-06T01:19:03.150192Z","end":"2026-05-06T01:19:03.276067Z","steps":["trace[1818049887] 'agreement among raft nodes before linearized reading'  (duration: 125.71073ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T01:19:03.276104Z","caller":"traceutil/trace.go:171","msg":"trace[137579818] transaction","detail":"{read_only:false; response_revision:3802; number_of_response:1; }","duration":"130.708908ms","start":"2026-05-06T01:19:03.145319Z","end":"2026-05-06T01:19:03.276028Z","steps":["trace[137579818] 'process raft request'  (duration: 39.258449ms)","trace[137579818] 'compare'  (duration: 91.142423ms)"],"step_count":2}
{"level":"info","ts":"2026-05-06T01:19:09.469967Z","caller":"traceutil/trace.go:171","msg":"trace[954820362] transaction","detail":"{read_only:false; response_revision:3850; number_of_response:1; }","duration":"156.808244ms","start":"2026-05-06T01:19:09.313137Z","end":"2026-05-06T01:19:09.469945Z","steps":["trace[954820362] 'process raft request'  (duration: 156.668371ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T01:19:09.490963Z","caller":"traceutil/trace.go:171","msg":"trace[1848530833] transaction","detail":"{read_only:false; response_revision:3851; number_of_response:1; }","duration":"166.8929ms","start":"2026-05-06T01:19:09.324042Z","end":"2026-05-06T01:19:09.490935Z","steps":["trace[1848530833] 'process raft request'  (duration: 166.747297ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T01:19:53.584614Z","caller":"traceutil/trace.go:171","msg":"trace[1573453213] transaction","detail":"{read_only:false; response_revision:4562; number_of_response:1; }","duration":"152.004368ms","start":"2026-05-06T01:19:53.432584Z","end":"2026-05-06T01:19:53.584589Z","steps":["trace[1573453213] 'process raft request'  (duration: 55.71203ms)","trace[1573453213] 'compare'  (duration: 95.937652ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-06T01:19:54.334161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.36177ms","expected-duration":"100ms","prefix":"","request":"header:<ID:11619742214270861247 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/local-path-storage/helper-pod-create-pvc-aff16a53-f030-4b35-b31e-df5fb85beb2d.18acd53919513cfc\" mod_revision:0 > success:<request_put:<key:\"/registry/events/local-path-storage/helper-pod-create-pvc-aff16a53-f030-4b35-b31e-df5fb85beb2d.18acd53919513cfc\" value_size:724 lease:2396370177416083700 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-05-06T01:19:54.334401Z","caller":"traceutil/trace.go:171","msg":"trace[957722125] transaction","detail":"{read_only:false; response_revision:4570; number_of_response:1; }","duration":"157.072734ms","start":"2026-05-06T01:19:54.177311Z","end":"2026-05-06T01:19:54.334383Z","steps":["trace[957722125] 'process raft request'  (duration: 156.980462ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T01:19:54.334489Z","caller":"traceutil/trace.go:171","msg":"trace[1919892027] linearizableReadLoop","detail":"{readStateIndex:4742; appliedIndex:4741; }","duration":"161.905209ms","start":"2026-05-06T01:19:54.172554Z","end":"2026-05-06T01:19:54.33446Z","steps":["trace[1919892027] 'read index received'  (duration: 12.123731ms)","trace[1919892027] 'applied index is now lower than readState.Index'  (duration: 149.778748ms)"],"step_count":2}
{"level":"info","ts":"2026-05-06T01:19:54.334565Z","caller":"traceutil/trace.go:171","msg":"trace[380560708] transaction","detail":"{read_only:false; response_revision:4569; number_of_response:1; }","duration":"212.959816ms","start":"2026-05-06T01:19:54.121587Z","end":"2026-05-06T01:19:54.334547Z","steps":["trace[380560708] 'process raft request'  (duration: 63.133316ms)","trace[380560708] 'compare'  (duration: 149.081626ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-06T01:19:54.33467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.54304ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12209"}
{"level":"info","ts":"2026-05-06T01:19:54.334707Z","caller":"traceutil/trace.go:171","msg":"trace[1229930092] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4570; }","duration":"184.630632ms","start":"2026-05-06T01:19:54.150067Z","end":"2026-05-06T01:19:54.334698Z","steps":["trace[1229930092] 'agreement among raft nodes before linearized reading'  (duration: 184.486959ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T01:19:54.334863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.862468ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-5e363253-6249-4e53-be84-0468672992d2\" ","response":"range_response_count:1 size:3773"}
{"level":"info","ts":"2026-05-06T01:19:54.334955Z","caller":"traceutil/trace.go:171","msg":"trace[882408568] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-5e363253-6249-4e53-be84-0468672992d2; range_end:; response_count:1; response_revision:4570; }","duration":"177.990501ms","start":"2026-05-06T01:19:54.156944Z","end":"2026-05-06T01:19:54.334934Z","steps":["trace[882408568] 'agreement among raft nodes before linearized reading'  (duration: 177.631143ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T01:19:54.58214Z","caller":"traceutil/trace.go:171","msg":"trace[1587397292] linearizableReadLoop","detail":"{readStateIndex:4744; appliedIndex:4743; }","duration":"231.646358ms","start":"2026-05-06T01:19:54.350472Z","end":"2026-05-06T01:19:54.582118Z","steps":["trace[1587397292] 'read index received'  (duration: 202.784004ms)","trace[1587397292] 'applied index is now lower than readState.Index'  (duration: 28.861174ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-06T01:19:54.582279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.788841ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"warn","ts":"2026-05-06T01:19:54.582329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.596633ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-06T01:19:54.582347Z","caller":"traceutil/trace.go:171","msg":"trace[1831293593] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:4571; }","duration":"231.901123ms","start":"2026-05-06T01:19:54.350434Z","end":"2026-05-06T01:19:54.582335Z","steps":["trace[1831293593] 'agreement among raft nodes before linearized reading'  (duration: 231.77542ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T01:19:54.582366Z","caller":"traceutil/trace.go:171","msg":"trace[1468859238] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:4571; }","duration":"178.685674ms","start":"2026-05-06T01:19:54.403671Z","end":"2026-05-06T01:19:54.582356Z","steps":["trace[1468859238] 'agreement among raft nodes before linearized reading'  (duration: 178.607622ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T01:19:54.582189Z","caller":"traceutil/trace.go:171","msg":"trace[273517383] transaction","detail":"{read_only:false; response_revision:4571; number_of_response:1; }","duration":"238.232009ms","start":"2026-05-06T01:19:54.34391Z","end":"2026-05-06T01:19:54.582142Z","steps":["trace[273517383] 'process raft request'  (duration: 209.376784ms)","trace[273517383] 'compare'  (duration: 28.745753ms)"],"step_count":2}
{"level":"info","ts":"2026-05-06T01:19:54.846997Z","caller":"traceutil/trace.go:171","msg":"trace[261649941] linearizableReadLoop","detail":"{readStateIndex:4745; appliedIndex:4744; }","duration":"246.230638ms","start":"2026-05-06T01:19:54.600738Z","end":"2026-05-06T01:19:54.846969Z","steps":["trace[261649941] 'read index received'  (duration: 246.070835ms)","trace[261649941] 'applied index is now lower than readState.Index'  (duration: 158.623µs)"],"step_count":2}
{"level":"warn","ts":"2026-05-06T01:19:54.847217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.443052ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5683"}
{"level":"info","ts":"2026-05-06T01:19:54.847262Z","caller":"traceutil/trace.go:171","msg":"trace[2055963271] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:4572; }","duration":"246.532894ms","start":"2026-05-06T01:19:54.600713Z","end":"2026-05-06T01:19:54.847246Z","steps":["trace[2055963271] 'agreement among raft nodes before linearized reading'  (duration: 246.35505ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T01:19:54.847347Z","caller":"traceutil/trace.go:171","msg":"trace[239736111] transaction","detail":"{read_only:false; response_revision:4572; number_of_response:1; }","duration":"251.493092ms","start":"2026-05-06T01:19:54.595816Z","end":"2026-05-06T01:19:54.847309Z","steps":["trace[239736111] 'process raft request'  (duration: 250.970692ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T01:19:54.908058Z","caller":"traceutil/trace.go:171","msg":"trace[96731546] transaction","detail":"{read_only:false; response_revision:4573; number_of_response:1; }","duration":"233.24653ms","start":"2026-05-06T01:19:54.674785Z","end":"2026-05-06T01:19:54.908031Z","steps":["trace[96731546] 'process raft request'  (duration: 233.086397ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T01:20:02.767993Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.845993ms","expected-duration":"100ms","prefix":"","request":"header:<ID:11619742214270861686 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/monitoring/prometheus-kube-prometheus-stack-prometheus-0.18acd53af795bc08\" mod_revision:0 > success:<request_put:<key:\"/registry/events/monitoring/prometheus-kube-prometheus-stack-prometheus-0.18acd53af795bc08\" value_size:706 lease:2396370177416085695 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-05-06T01:20:02.768205Z","caller":"traceutil/trace.go:171","msg":"trace[978128601] linearizableReadLoop","detail":"{readStateIndex:4931; appliedIndex:4930; }","duration":"565.720661ms","start":"2026-05-06T01:20:02.202466Z","end":"2026-05-06T01:20:02.768187Z","steps":["trace[978128601] 'read index received'  (duration: 243.628683ms)","trace[978128601] 'applied index is now lower than readState.Index'  (duration: 322.089658ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-06T01:20:02.768492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.481809ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-05-06T01:20:02.768567Z","caller":"traceutil/trace.go:171","msg":"trace[144468925] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:4751; }","duration":"249.617141ms","start":"2026-05-06T01:20:02.518932Z","end":"2026-05-06T01:20:02.768549Z","steps":["trace[144468925] 'agreement among raft nodes before linearized reading'  (duration: 249.468918ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T01:20:02.768524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"555.338438ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1821"}
{"level":"warn","ts":"2026-05-06T01:20:02.768573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"566.067658ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"}
{"level":"warn","ts":"2026-05-06T01:20:02.768578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.543721ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-06T01:20:02.768654Z","caller":"traceutil/trace.go:171","msg":"trace[1971685646] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:4751; }","duration":"555.48866ms","start":"2026-05-06T01:20:02.213152Z","end":"2026-05-06T01:20:02.768641Z","steps":["trace[1971685646] 'agreement among raft nodes before linearized reading'  (duration: 555.173934ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T01:20:02.768696Z","caller":"traceutil/trace.go:171","msg":"trace[2063111606] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4751; }","duration":"566.224552ms","start":"2026-05-06T01:20:02.202441Z","end":"2026-05-06T01:20:02.768666Z","steps":["trace[2063111606] 'agreement among raft nodes before linearized reading'  (duration: 565.874115ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T01:20:02.768719Z","caller":"traceutil/trace.go:171","msg":"trace[1449072370] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4751; }","duration":"153.698425ms","start":"2026-05-06T01:20:02.614977Z","end":"2026-05-06T01:20:02.768675Z","steps":["trace[1449072370] 'agreement among raft nodes before linearized reading'  (duration: 153.479871ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T01:20:02.768755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"487.751817ms","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":"warn","ts":"2026-05-06T01:20:02.768771Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:20:02.20243Z","time spent":"566.325423ms","remote":"127.0.0.1:46748","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":577,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"warn","ts":"2026-05-06T01:20:02.768776Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:20:02.213131Z","time spent":"555.631562ms","remote":"127.0.0.1:46566","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":1843,"request content":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" "}
{"level":"info","ts":"2026-05-06T01:20:02.768827Z","caller":"traceutil/trace.go:171","msg":"trace[1656302371] 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:4751; }","duration":"487.835238ms","start":"2026-05-06T01:20:02.280972Z","end":"2026-05-06T01:20:02.768807Z","steps":["trace[1656302371] 'agreement among raft nodes before linearized reading'  (duration: 487.660525ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T01:20:02.768875Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:20:02.280967Z","time spent":"487.893949ms","remote":"127.0.0.1:46654","response type":"/etcdserverpb.KV/Range","request count":0,"request size":147,"response count":1,"response size":1957,"request content":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" "}
{"level":"warn","ts":"2026-05-06T01:20:02.768945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.504365ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-05-06T01:20:02.768697Z","caller":"traceutil/trace.go:171","msg":"trace[789395707] transaction","detail":"{read_only:false; response_revision:4751; number_of_response:1; }","duration":"619.918778ms","start":"2026-05-06T01:20:02.148746Z","end":"2026-05-06T01:20:02.768665Z","steps":["trace[789395707] 'process raft request'  (duration: 297.33558ms)","trace[789395707] 'compare'  (duration: 321.482236ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-06T01:20:02.769143Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:20:02.148729Z","time spent":"620.299585ms","remote":"127.0.0.1:46548","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":814,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/events/monitoring/prometheus-kube-prometheus-stack-prometheus-0.18acd53af795bc08\" mod_revision:0 > success:<request_put:<key:\"/registry/events/monitoring/prometheus-kube-prometheus-stack-prometheus-0.18acd53af795bc08\" value_size:706 lease:2396370177416085695 >> failure:<>"}
{"level":"warn","ts":"2026-05-06T01:20:02.769385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"519.619894ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:12972"}
{"level":"info","ts":"2026-05-06T01:20:02.769505Z","caller":"traceutil/trace.go:171","msg":"trace[220162106] range","detail":"{range_begin:/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4751; }","duration":"519.803128ms","start":"2026-05-06T01:20:02.24969Z","end":"2026-05-06T01:20:02.769493Z","steps":["trace[220162106] 'agreement among raft nodes before linearized reading'  (duration: 519.456241ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T01:20:02.769613Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:20:02.249677Z","time spent":"519.92348ms","remote":"127.0.0.1:46684","response type":"/etcdserverpb.KV/Range","request count":0,"request size":77,"response count":1,"response size":12994,"request content":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" "}
{"level":"info","ts":"2026-05-06T01:20:02.769033Z","caller":"traceutil/trace.go:171","msg":"trace[1179106581] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:4751; }","duration":"170.010234ms","start":"2026-05-06T01:20:02.599Z","end":"2026-05-06T01:20:02.76901Z","steps":["trace[1179106581] 'agreement among raft nodes before linearized reading'  (duration: 169.502594ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T01:20:02.770113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"351.640549ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"}
{"level":"info","ts":"2026-05-06T01:20:02.770943Z","caller":"traceutil/trace.go:171","msg":"trace[836603483] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4751; }","duration":"353.411673ms","start":"2026-05-06T01:20:02.417516Z","end":"2026-05-06T01:20:02.770928Z","steps":["trace[836603483] 'agreement among raft nodes before linearized reading'  (duration: 351.389513ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T01:20:02.771041Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:20:02.417493Z","time spent":"353.530996ms","remote":"127.0.0.1:46748","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"info","ts":"2026-05-06T01:20:02.946568Z","caller":"traceutil/trace.go:171","msg":"trace[818934900] linearizableReadLoop","detail":"{readStateIndex:4932; appliedIndex:4931; }","duration":"170.528446ms","start":"2026-05-06T01:20:02.775996Z","end":"2026-05-06T01:20:02.946524Z","steps":["trace[818934900] 'read index received'  (duration: 145.116536ms)","trace[818934900] 'applied index is now lower than readState.Index'  (duration: 25.41058ms)"],"step_count":2}
{"level":"info","ts":"2026-05-06T01:20:02.94664Z","caller":"traceutil/trace.go:171","msg":"trace[164856576] transaction","detail":"{read_only:false; response_revision:4752; number_of_response:1; }","duration":"170.901542ms","start":"2026-05-06T01:20:02.77571Z","end":"2026-05-06T01:20:02.946611Z","steps":["trace[164856576] 'process raft request'  (duration: 145.38879ms)","trace[164856576] 'compare'  (duration: 25.301798ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-06T01:20:02.947052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.015225ms","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-05-06T01:20:02.947346Z","caller":"traceutil/trace.go:171","msg":"trace[1976725509] 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:4752; }","duration":"171.349571ms","start":"2026-05-06T01:20:02.775973Z","end":"2026-05-06T01:20:02.947323Z","steps":["trace[1976725509] 'agreement among raft nodes before linearized reading'  (duration: 170.75843ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T01:20:02.980934Z","caller":"traceutil/trace.go:171","msg":"trace[1044609462] transaction","detail":"{read_only:false; response_revision:4753; number_of_response:1; }","duration":"204.82547ms","start":"2026-05-06T01:20:02.776092Z","end":"2026-05-06T01:20:02.980918Z","steps":["trace[1044609462] 'process raft request'  (duration: 204.615426ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T01:20:02.980984Z","caller":"traceutil/trace.go:171","msg":"trace[1421643757] transaction","detail":"{read_only:false; response_revision:4754; number_of_response:1; }","duration":"204.054065ms","start":"2026-05-06T01:20:02.776908Z","end":"2026-05-06T01:20:02.980962Z","steps":["trace[1421643757] 'process raft request'  (duration: 203.919512ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T01:20:02.981124Z","caller":"traceutil/trace.go:171","msg":"trace[621776353] transaction","detail":"{read_only:false; response_revision:4755; number_of_response:1; }","duration":"198.141139ms","start":"2026-05-06T01:20:02.782962Z","end":"2026-05-06T01:20:02.981103Z","steps":["trace[621776353] 'process raft request'  (duration: 197.925024ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T01:20:02.986112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.192951ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3506"}
{"level":"info","ts":"2026-05-06T01:20:02.986176Z","caller":"traceutil/trace.go:171","msg":"trace[222107977] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:4756; }","duration":"195.286072ms","start":"2026-05-06T01:20:02.790876Z","end":"2026-05-06T01:20:02.986162Z","steps":["trace[222107977] 'agreement among raft nodes before linearized reading'  (duration: 195.16293ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T01:20:03.440321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.788317ms","expected-duration":"100ms","prefix":"","request":"header:<ID:11619742214270861726 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/monitoring.coreos.com/prometheuses/monitoring/kube-prometheus-stack-prometheus\" mod_revision:4611 > success:<request_put:<key:\"/registry/monitoring.coreos.com/prometheuses/monitoring/kube-prometheus-stack-prometheus\" value_size:7470 >> failure:<request_range:<key:\"/registry/monitoring.coreos.com/prometheuses/monitoring/kube-prometheus-stack-prometheus\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-06T01:20:03.440416Z","caller":"traceutil/trace.go:171","msg":"trace[801807678] linearizableReadLoop","detail":"{readStateIndex:4950; appliedIndex:4949; }","duration":"184.677479ms","start":"2026-05-06T01:20:03.255723Z","end":"2026-05-06T01:20:03.4404Z","steps":["trace[801807678] 'read index received'  (duration: 30.371µs)","trace[801807678] 'applied index is now lower than readState.Index'  (duration: 184.646028ms)"],"step_count":2}
{"level":"info","ts":"2026-05-06T01:20:03.440672Z","caller":"traceutil/trace.go:171","msg":"trace[898256866] transaction","detail":"{read_only:false; response_revision:4770; number_of_response:1; }","duration":"269.408074ms","start":"2026-05-06T01:20:03.171248Z","end":"2026-05-06T01:20:03.440627Z","steps":["trace[898256866] 'process raft request'  (duration: 45.210199ms)","trace[898256866] 'compare'  (duration: 223.331218ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-06T01:20:03.440866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.710733ms","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-05-06T01:20:03.440937Z","caller":"traceutil/trace.go:171","msg":"trace[1999685360] 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:4770; }","duration":"144.830566ms","start":"2026-05-06T01:20:03.296088Z","end":"2026-05-06T01:20:03.440918Z","steps":["trace[1999685360] 'agreement among raft nodes before linearized reading'  (duration: 144.644523ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T01:20:03.441099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.577902ms","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-05-06T01:20:03.441149Z","caller":"traceutil/trace.go:171","msg":"trace[1790145181] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:4770; }","duration":"112.702494ms","start":"2026-05-06T01:20:03.328434Z","end":"2026-05-06T01:20:03.441137Z","steps":["trace[1790145181] 'agreement among raft nodes before linearized reading'  (duration: 112.593962ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T01:20:03.441187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.457594ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-grafana-844cf65499-drqrr.18acd53ac1c66061\" ","response":"range_response_count:1 size:898"}
{"level":"info","ts":"2026-05-06T01:20:03.441283Z","caller":"traceutil/trace.go:171","msg":"trace[994919014] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-grafana-844cf65499-drqrr.18acd53ac1c66061; range_end:; response_count:1; response_revision:4770; }","duration":"185.584767ms","start":"2026-05-06T01:20:03.255688Z","end":"2026-05-06T01:20:03.441273Z","steps":["trace[994919014] 'agreement among raft nodes before linearized reading'  (duration: 185.392353ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T01:20:03.824598Z","caller":"traceutil/trace.go:171","msg":"trace[946894403] linearizableReadLoop","detail":"{readStateIndex:4951; appliedIndex:4950; }","duration":"377.936446ms","start":"2026-05-06T01:20:03.446638Z","end":"2026-05-06T01:20:03.824575Z","steps":["trace[946894403] 'read index received'  (duration: 377.753663ms)","trace[946894403] 'applied index is now lower than readState.Index'  (duration: 181.603µs)"],"step_count":2}
{"level":"info","ts":"2026-05-06T01:20:03.824613Z","caller":"traceutil/trace.go:171","msg":"trace[836711309] transaction","detail":"{read_only:false; response_revision:4771; number_of_response:1; }","duration":"380.353665ms","start":"2026-05-06T01:20:03.444236Z","end":"2026-05-06T01:20:03.82459Z","steps":["trace[836711309] 'process raft request'  (duration: 380.194202ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T01:20:03.824779Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:20:03.444216Z","time spent":"380.484827ms","remote":"127.0.0.1:46548","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/events/monitoring/kube-prometheus-stack-grafana-844cf65499-drqrr.18acd53ac1c66061\" mod_revision:4753 > success:<request_put:<key:\"/registry/events/monitoring/kube-prometheus-stack-grafana-844cf65499-drqrr.18acd53ac1c66061\" value_size:774 lease:2396370177416085695 >> failure:<request_range:<key:\"/registry/events/monitoring/kube-prometheus-stack-grafana-844cf65499-drqrr.18acd53ac1c66061\" > >"}
{"level":"warn","ts":"2026-05-06T01:20:03.824794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.140341ms","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-05-06T01:20:03.824932Z","caller":"traceutil/trace.go:171","msg":"trace[1986203502] 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:4771; }","duration":"378.308134ms","start":"2026-05-06T01:20:03.446611Z","end":"2026-05-06T01:20:03.824919Z","steps":["trace[1986203502] 'agreement among raft nodes before linearized reading'  (duration: 378.048789ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T01:20:03.824963Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:20:03.446603Z","time spent":"378.351485ms","remote":"127.0.0.1:46654","response type":"/etcdserverpb.KV/Range","request count":0,"request size":139,"response count":1,"response size":2104,"request content":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" "}
{"level":"warn","ts":"2026-05-06T01:20:03.840706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"371.99418ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1821"}
{"level":"info","ts":"2026-05-06T01:20:03.840976Z","caller":"traceutil/trace.go:171","msg":"trace[1114551133] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:4772; }","duration":"372.257825ms","start":"2026-05-06T01:20:03.468636Z","end":"2026-05-06T01:20:03.840894Z","steps":["trace[1114551133] 'agreement among raft nodes before linearized reading'  (duration: 371.862918ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T01:20:03.8411Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:20:03.468619Z","time spent":"372.463489ms","remote":"127.0.0.1:46566","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":1843,"request content":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" "}
{"level":"warn","ts":"2026-05-06T01:20:04.036669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.837073ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/prometheuses/monitoring/kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:7581"}
{"level":"warn","ts":"2026-05-06T01:20:04.036853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.510101ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"}
{"level":"info","ts":"2026-05-06T01:20:04.036954Z","caller":"traceutil/trace.go:171","msg":"trace[1135782803] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4772; }","duration":"109.655744ms","start":"2026-05-06T01:20:03.927276Z","end":"2026-05-06T01:20:04.036931Z","steps":["trace[1135782803] 'range keys from in-memory index tree'  (duration: 109.291357ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T01:20:04.03676Z","caller":"traceutil/trace.go:171","msg":"trace[1912826104] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheuses/monitoring/kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:4772; }","duration":"124.979676ms","start":"2026-05-06T01:20:03.911761Z","end":"2026-05-06T01:20:04.036741Z","steps":["trace[1912826104] 'range keys from in-memory index tree'  (duration: 124.629319ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T01:20:06.359367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.642089ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.82\" ","response":"range_response_count:1 size:133"}
{"level":"info","ts":"2026-05-06T01:20:06.359448Z","caller":"traceutil/trace.go:171","msg":"trace[1667407101] range","detail":"{range_begin:/registry/masterleases/199.19.213.82; range_end:; response_count:1; response_revision:4801; }","duration":"198.77711ms","start":"2026-05-06T01:20:06.160652Z","end":"2026-05-06T01:20:06.359429Z","steps":["trace[1667407101] 'range keys from in-memory index tree'  (duration: 198.452744ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T01:20:11.705167Z","caller":"traceutil/trace.go:171","msg":"trace[1241599782] transaction","detail":"{read_only:false; response_revision:4894; number_of_response:1; }","duration":"196.305928ms","start":"2026-05-06T01:20:11.508841Z","end":"2026-05-06T01:20:11.705147Z","steps":["trace[1241599782] 'process raft request'  (duration: 189.819433ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T01:20:15.695645Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11619742214270862095,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-05-06T01:20:15.996712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"862.834819ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12209"}
{"level":"info","ts":"2026-05-06T01:20:15.996821Z","caller":"traceutil/trace.go:171","msg":"trace[39112543] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4916; }","duration":"862.984162ms","start":"2026-05-06T01:20:15.133809Z","end":"2026-05-06T01:20:15.996793Z","steps":["trace[39112543] 'range keys from in-memory index tree'  (duration: 862.573684ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T01:20:15.99678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"886.980217ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-06T01:20:15.996872Z","caller":"traceutil/trace.go:171","msg":"trace[879344263] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:4916; }","duration":"887.077289ms","start":"2026-05-06T01:20:15.109781Z","end":"2026-05-06T01:20:15.996858Z","steps":["trace[879344263] 'range keys from in-memory index tree'  (duration: 886.967847ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T01:20:15.996877Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:20:15.133791Z","time spent":"863.070614ms","remote":"127.0.0.1:46684","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12231,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "}
{"level":"warn","ts":"2026-05-06T01:20:15.997164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.713897ms","expected-duration":"100ms","prefix":"","request":"header:<ID:11619742214270862096 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:4902 > 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-05-06T01:20:15.997226Z","caller":"traceutil/trace.go:171","msg":"trace[1871456530] transaction","detail":"{read_only:false; response_revision:4917; number_of_response:1; }","duration":"843.107197ms","start":"2026-05-06T01:20:15.154106Z","end":"2026-05-06T01:20:15.997213Z","steps":["trace[1871456530] 'process raft request'  (duration: 584.283008ms)","trace[1871456530] 'compare'  (duration: 258.35114ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-06T01:20:15.997274Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:20:15.154067Z","time spent":"843.182159ms","remote":"127.0.0.1:46748","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:4902 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-05-06T01:20:16.006623Z","caller":"traceutil/trace.go:171","msg":"trace[829495347] linearizableReadLoop","detail":"{readStateIndex:5104; appliedIndex:5102; }","duration":"811.469835ms","start":"2026-05-06T01:20:15.195143Z","end":"2026-05-06T01:20:16.006613Z","steps":["trace[829495347] 'read index received'  (duration: 543.259224ms)","trace[829495347] 'applied index is now lower than readState.Index'  (duration: 268.209951ms)"],"step_count":2}
{"level":"info","ts":"2026-05-06T01:20:16.00685Z","caller":"traceutil/trace.go:171","msg":"trace[1902719623] transaction","detail":"{read_only:false; response_revision:4918; number_of_response:1; }","duration":"797.892602ms","start":"2026-05-06T01:20:15.208945Z","end":"2026-05-06T01:20:16.006837Z","steps":["trace[1902719623] 'process raft request'  (duration: 797.605487ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T01:20:16.006921Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:20:15.208919Z","time spent":"797.962244ms","remote":"127.0.0.1:46748","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:4790 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:599 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"warn","ts":"2026-05-06T01:20:16.007049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"811.980255ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-05-06T01:20:16.007159Z","caller":"traceutil/trace.go:171","msg":"trace[590240301] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4918; }","duration":"812.171799ms","start":"2026-05-06T01:20:15.194962Z","end":"2026-05-06T01:20:16.007133Z","steps":["trace[590240301] 'agreement among raft nodes before linearized reading'  (duration: 811.847553ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T01:20:16.00721Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:20:15.194926Z","time spent":"812.275841ms","remote":"127.0.0.1:46748","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-05-06T01:20:16.014239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"818.168624ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-05-06T01:20:16.014321Z","caller":"traceutil/trace.go:171","msg":"trace[381406196] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4919; }","duration":"818.298337ms","start":"2026-05-06T01:20:15.196011Z","end":"2026-05-06T01:20:16.014309Z","steps":["trace[381406196] 'agreement among raft nodes before linearized reading'  (duration: 818.122704ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T01:20:16.01432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"623.192401ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"}
{"level":"warn","ts":"2026-05-06T01:20:16.014449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"655.809423ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:10391"}
{"level":"info","ts":"2026-05-06T01:20:16.01451Z","caller":"traceutil/trace.go:171","msg":"trace[1652500883] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4919; }","duration":"655.900144ms","start":"2026-05-06T01:20:15.358603Z","end":"2026-05-06T01:20:16.014503Z","steps":["trace[1652500883] 'agreement among raft nodes before linearized reading'  (duration: 655.798542ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T01:20:16.014546Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:20:15.358586Z","time spent":"655.953255ms","remote":"127.0.0.1:46684","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":10413,"request content":"key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" "}
{"level":"info","ts":"2026-05-06T01:20:16.01463Z","caller":"traceutil/trace.go:171","msg":"trace[626640415] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4919; }","duration":"623.404695ms","start":"2026-05-06T01:20:15.391064Z","end":"2026-05-06T01:20:16.014468Z","steps":["trace[626640415] 'agreement among raft nodes before linearized reading'  (duration: 623.100409ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T01:20:16.014788Z","caller":"traceutil/trace.go:171","msg":"trace[1823527495] transaction","detail":"{read_only:false; response_revision:4919; number_of_response:1; }","duration":"126.980098ms","start":"2026-05-06T01:20:15.887785Z","end":"2026-05-06T01:20:16.014765Z","steps":["trace[1823527495] 'process raft request'  (duration: 126.274833ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T01:20:16.014831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"797.609727ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-06T01:20:16.014908Z","caller":"traceutil/trace.go:171","msg":"trace[641916284] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4919; }","duration":"797.700719ms","start":"2026-05-06T01:20:15.217195Z","end":"2026-05-06T01:20:16.014896Z","steps":["trace[641916284] 'agreement among raft nodes before linearized reading'  (duration: 797.590157ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T01:20:16.014972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"399.479012ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-05-06T01:20:16.015006Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:20:15.217158Z","time spent":"797.840341ms","remote":"127.0.0.1:46448","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-05-06T01:20:16.015036Z","caller":"traceutil/trace.go:171","msg":"trace[1282867513] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4919; }","duration":"399.586143ms","start":"2026-05-06T01:20:15.615434Z","end":"2026-05-06T01:20:16.01502Z","steps":["trace[1282867513] 'agreement among raft nodes before linearized reading'  (duration: 399.500422ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T01:20:16.015087Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:20:15.615384Z","time spent":"399.689315ms","remote":"127.0.0.1:46446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-05-06T01:20:16.014802Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:20:15.391041Z","time spent":"623.64528ms","remote":"127.0.0.1:46654","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":1,"response size":1887,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" "}
{"level":"warn","ts":"2026-05-06T01:20:16.015224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"800.960812ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/\" range_end:\"/registry/rabbitmq.com/rabbitmqclusters0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-05-06T01:20:16.015422Z","caller":"traceutil/trace.go:171","msg":"trace[1910311744] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/; range_end:/registry/rabbitmq.com/rabbitmqclusters0; response_count:0; response_revision:4919; }","duration":"801.218927ms","start":"2026-05-06T01:20:15.214191Z","end":"2026-05-06T01:20:16.01541Z","steps":["trace[1910311744] 'agreement among raft nodes before linearized reading'  (duration: 800.981112ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T01:20:16.014363Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:20:15.195982Z","time spent":"818.373328ms","remote":"127.0.0.1:46748","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-05-06T01:20:16.015458Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:20:15.214168Z","time spent":"801.279998ms","remote":"127.0.0.1:56664","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":1,"response size":29,"request content":"key:\"/registry/rabbitmq.com/rabbitmqclusters/\" range_end:\"/registry/rabbitmq.com/rabbitmqclusters0\" count_only:true "}
{"level":"info","ts":"2026-05-06T01:20:16.149467Z","caller":"traceutil/trace.go:171","msg":"trace[367400355] transaction","detail":"{read_only:false; response_revision:4922; number_of_response:1; }","duration":"123.822155ms","start":"2026-05-06T01:20:16.025615Z","end":"2026-05-06T01:20:16.149437Z","steps":["trace[367400355] 'process raft request'  (duration: 123.520599ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T01:20:16.14944Z","caller":"traceutil/trace.go:171","msg":"trace[888742810] transaction","detail":"{read_only:false; response_revision:4923; number_of_response:1; }","duration":"120.327476ms","start":"2026-05-06T01:20:16.02907Z","end":"2026-05-06T01:20:16.149398Z","steps":["trace[888742810] 'process raft request'  (duration: 120.150432ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T01:20:16.149552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.022984ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-c70f7561-eb7a-468b-8bac-4c2561b11049\" ","response":"range_response_count:1 size:1322"}
{"level":"info","ts":"2026-05-06T01:20:16.149657Z","caller":"traceutil/trace.go:171","msg":"trace[1242122587] range","detail":"{range_begin:/registry/persistentvolumes/pvc-c70f7561-eb7a-468b-8bac-4c2561b11049; range_end:; response_count:1; response_revision:4923; }","duration":"130.152706ms","start":"2026-05-06T01:20:16.019478Z","end":"2026-05-06T01:20:16.149631Z","steps":["trace[1242122587] 'agreement among raft nodes before linearized reading'  (duration: 129.884941ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T01:20:16.149337Z","caller":"traceutil/trace.go:171","msg":"trace[116936626] transaction","detail":"{read_only:false; response_revision:4921; number_of_response:1; }","duration":"128.038615ms","start":"2026-05-06T01:20:16.021252Z","end":"2026-05-06T01:20:16.14929Z","steps":["trace[116936626] 'process raft request'  (duration: 113.878901ms)","trace[116936626] 'compare'  (duration: 13.826796ms)"],"step_count":2}
{"level":"info","ts":"2026-05-06T01:20:16.539697Z","caller":"traceutil/trace.go:171","msg":"trace[2099884713] transaction","detail":"{read_only:false; response_revision:4932; number_of_response:1; }","duration":"149.904149ms","start":"2026-05-06T01:20:16.389761Z","end":"2026-05-06T01:20:16.539666Z","steps":["trace[2099884713] 'process raft request'  (duration: 149.632163ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T01:20:16.74004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.353753ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-06T01:20:16.740122Z","caller":"traceutil/trace.go:171","msg":"trace[1818539715] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4932; }","duration":"124.520757ms","start":"2026-05-06T01:20:16.615583Z","end":"2026-05-06T01:20:16.740104Z","steps":["trace[1818539715] 'range keys from in-memory index tree'  (duration: 124.262312ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T01:20:53.367928Z","caller":"traceutil/trace.go:171","msg":"trace[1153200381] linearizableReadLoop","detail":"{readStateIndex:5462; appliedIndex:5461; }","duration":"126.854867ms","start":"2026-05-06T01:20:53.241055Z","end":"2026-05-06T01:20:53.367909Z","steps":["trace[1153200381] 'read index received'  (duration: 62.310667ms)","trace[1153200381] 'applied index is now lower than readState.Index'  (duration: 64.54308ms)"],"step_count":2}
{"level":"info","ts":"2026-05-06T01:20:53.368022Z","caller":"traceutil/trace.go:171","msg":"trace[820548905] transaction","detail":"{read_only:false; response_revision:5267; number_of_response:1; }","duration":"136.980136ms","start":"2026-05-06T01:20:53.231034Z","end":"2026-05-06T01:20:53.368014Z","steps":["trace[820548905] 'process raft request'  (duration: 72.351544ms)","trace[820548905] 'compare'  (duration: 64.279094ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-06T01:20:53.368411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.537186ms","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-05-06T01:20:53.368458Z","caller":"traceutil/trace.go:171","msg":"trace[361518405] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5267; }","duration":"116.625647ms","start":"2026-05-06T01:20:53.251819Z","end":"2026-05-06T01:20:53.368445Z","steps":["trace[361518405] 'agreement among raft nodes before linearized reading'  (duration: 116.453244ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T01:20:53.368493Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.419398ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:4725"}
{"level":"info","ts":"2026-05-06T01:20:53.368578Z","caller":"traceutil/trace.go:171","msg":"trace[585433217] range","detail":"{range_begin:/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:5267; }","duration":"127.54467ms","start":"2026-05-06T01:20:53.241016Z","end":"2026-05-06T01:20:53.368561Z","steps":["trace[585433217] 'agreement among raft nodes before linearized reading'  (duration: 127.280396ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T01:20:53.680363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.093231ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0\" ","response":"range_response_count:1 size:1342"}
{"level":"info","ts":"2026-05-06T01:20:53.680451Z","caller":"traceutil/trace.go:171","msg":"trace[1402758177] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0; range_end:; response_count:1; response_revision:5268; }","duration":"212.200863ms","start":"2026-05-06T01:20:53.468227Z","end":"2026-05-06T01:20:53.680428Z","steps":["trace[1402758177] 'range keys from in-memory index tree'  (duration: 211.833907ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T01:21:04.374058Z","caller":"traceutil/trace.go:171","msg":"trace[221685430] transaction","detail":"{read_only:false; response_revision:5346; number_of_response:1; }","duration":"130.124684ms","start":"2026-05-06T01:21:04.243879Z","end":"2026-05-06T01:21:04.374003Z","steps":["trace[221685430] 'process raft request'  (duration: 126.343784ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T01:21:42.80321Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2920}
{"level":"info","ts":"2026-05-06T01:21:42.897526Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2920,"took":"91.929452ms","hash":277924137,"current-db-size-bytes":54325248,"current-db-size":"54 MB","current-db-size-in-use-bytes":29421568,"current-db-size-in-use":"29 MB"}
{"level":"info","ts":"2026-05-06T01:21:42.897584Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":277924137,"revision":2920,"compact-revision":-1}
{"level":"warn","ts":"2026-05-06T01:22:11.643948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.639984ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-05-06T01:22:11.644063Z","caller":"traceutil/trace.go:171","msg":"trace[1815347764] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:5800; }","duration":"249.810528ms","start":"2026-05-06T01:22:11.394227Z","end":"2026-05-06T01:22:11.644038Z","steps":["trace[1815347764] 'count revisions from in-memory index tree'  (duration: 249.560002ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T01:22:11.645015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.513739ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-05-06T01:22:11.645224Z","caller":"traceutil/trace.go:171","msg":"trace[1371391290] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:5800; }","duration":"287.832315ms","start":"2026-05-06T01:22:11.35737Z","end":"2026-05-06T01:22:11.645202Z","steps":["trace[1371391290] 'count revisions from in-memory index tree'  (duration: 287.420157ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T01:22:39.358387Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11619742214270864730,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-05-06T01:22:39.569585Z","caller":"traceutil/trace.go:171","msg":"trace[533762662] transaction","detail":"{read_only:false; response_revision:5937; number_of_response:1; }","duration":"821.4396ms","start":"2026-05-06T01:22:38.748115Z","end":"2026-05-06T01:22:39.569555Z","steps":["trace[533762662] 'process raft request'  (duration: 821.154105ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T01:22:39.569937Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:22:38.748085Z","time spent":"821.632013ms","remote":"127.0.0.1:46748","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:5928 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"info","ts":"2026-05-06T01:22:39.570827Z","caller":"traceutil/trace.go:171","msg":"trace[132579419] linearizableReadLoop","detail":"{readStateIndex:6156; appliedIndex:6154; }","duration":"712.955281ms","start":"2026-05-06T01:22:38.857849Z","end":"2026-05-06T01:22:39.570805Z","steps":["trace[132579419] 'read index received'  (duration: 711.567776ms)","trace[132579419] 'applied index is now lower than readState.Index'  (duration: 1.386605ms)"],"step_count":2}
{"level":"info","ts":"2026-05-06T01:22:39.57112Z","caller":"traceutil/trace.go:171","msg":"trace[804617102] transaction","detail":"{read_only:false; response_revision:5938; number_of_response:1; }","duration":"680.767853ms","start":"2026-05-06T01:22:38.890339Z","end":"2026-05-06T01:22:39.571107Z","steps":["trace[804617102] 'process raft request'  (duration: 680.332906ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T01:22:39.571224Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:22:38.89032Z","time spent":"680.825004ms","remote":"127.0.0.1:46748","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:5887 > 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-05-06T01:22:39.571356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"683.101413ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"}
{"level":"info","ts":"2026-05-06T01:22:39.571428Z","caller":"traceutil/trace.go:171","msg":"trace[475182476] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5938; }","duration":"683.251356ms","start":"2026-05-06T01:22:38.88816Z","end":"2026-05-06T01:22:39.571411Z","steps":["trace[475182476] 'agreement among raft nodes before linearized reading'  (duration: 683.018012ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T01:22:39.571463Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:22:38.88814Z","time spent":"683.315067ms","remote":"127.0.0.1:46748","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-05-06T01:22:39.571582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"550.009196ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12209"}
{"level":"info","ts":"2026-05-06T01:22:39.571638Z","caller":"traceutil/trace.go:171","msg":"trace[1291102440] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5938; }","duration":"550.125028ms","start":"2026-05-06T01:22:39.021504Z","end":"2026-05-06T01:22:39.571629Z","steps":["trace[1291102440] 'agreement among raft nodes before linearized reading'  (duration: 549.970955ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T01:22:39.571649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.948731ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"warn","ts":"2026-05-06T01:22:39.571682Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:22:39.021473Z","time spent":"550.19665ms","remote":"127.0.0.1:46684","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12231,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "}
{"level":"info","ts":"2026-05-06T01:22:39.571688Z","caller":"traceutil/trace.go:171","msg":"trace[1341369594] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:5938; }","duration":"197.116654ms","start":"2026-05-06T01:22:39.37456Z","end":"2026-05-06T01:22:39.571676Z","steps":["trace[1341369594] 'agreement among raft nodes before linearized reading'  (duration: 197.012822ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T01:22:39.57197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"683.736284ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"}
{"level":"info","ts":"2026-05-06T01:22:39.572001Z","caller":"traceutil/trace.go:171","msg":"trace[1174987965] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5938; }","duration":"683.814075ms","start":"2026-05-06T01:22:38.888177Z","end":"2026-05-06T01:22:39.571991Z","steps":["trace[1174987965] 'agreement among raft nodes before linearized reading'  (duration: 683.745584ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T01:22:39.572022Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:22:38.888141Z","time spent":"683.875506ms","remote":"127.0.0.1:46748","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-05-06T01:22:39.572058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"714.208392ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-06T01:22:39.572092Z","caller":"traceutil/trace.go:171","msg":"trace[1589725620] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:5938; }","duration":"714.287644ms","start":"2026-05-06T01:22:38.857795Z","end":"2026-05-06T01:22:39.572083Z","steps":["trace[1589725620] 'agreement among raft nodes before linearized reading'  (duration: 714.225383ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T01:22:39.572118Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:22:38.857771Z","time spent":"714.340344ms","remote":"127.0.0.1:36672","response type":"/etcdserverpb.KV/Range","request count":0,"request size":112,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true "}
{"level":"warn","ts":"2026-05-06T01:22:39.572128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"583.455695ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-05-06T01:22:39.57221Z","caller":"traceutil/trace.go:171","msg":"trace[1206509878] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5938; }","duration":"583.617369ms","start":"2026-05-06T01:22:38.98858Z","end":"2026-05-06T01:22:39.572197Z","steps":["trace[1206509878] 'agreement among raft nodes before linearized reading'  (duration: 583.373264ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T01:22:39.572251Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:22:38.988566Z","time spent":"583.677999ms","remote":"127.0.0.1:46748","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-05-06T01:22:39.572251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"681.515016ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"}
{"level":"info","ts":"2026-05-06T01:22:39.572336Z","caller":"traceutil/trace.go:171","msg":"trace[642289976] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5938; }","duration":"681.637767ms","start":"2026-05-06T01:22:38.890656Z","end":"2026-05-06T01:22:39.572294Z","steps":["trace[642289976] 'agreement among raft nodes before linearized reading'  (duration: 681.257931ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-06T01:22:39.572376Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:22:38.890649Z","time spent":"681.717228ms","remote":"127.0.0.1:46748","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-05-06T01:26:38.689679Z","caller":"traceutil/trace.go:171","msg":"trace[1850017193] transaction","detail":"{read_only:false; response_revision:7433; number_of_response:1; }","duration":"118.686163ms","start":"2026-05-06T01:26:38.570954Z","end":"2026-05-06T01:26:38.68964Z","steps":["trace[1850017193] 'process raft request'  (duration: 118.365573ms)"],"step_count":1}
{"level":"info","ts":"2026-05-06T01:26:42.810168Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5657}
{"level":"info","ts":"2026-05-06T01:26:42.895677Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5657,"took":"83.739866ms","hash":2217999132,"current-db-size-bytes":54325248,"current-db-size":"54 MB","current-db-size-in-use-bytes":18288640,"current-db-size-in-use":"18 MB"}
{"level":"info","ts":"2026-05-06T01:26:42.89576Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2217999132,"revision":5657,"compact-revision":2920}
{"level":"warn","ts":"2026-05-06T01:28:20.130415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.538001ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/openstack/keystone-etc\" ","response":"range_response_count:1 size:11493"}
{"level":"info","ts":"2026-05-06T01:28:20.130496Z","caller":"traceutil/trace.go:171","msg":"trace[444980784] range","detail":"{range_begin:/registry/secrets/openstack/keystone-etc; range_end:; response_count:1; response_revision:7949; }","duration":"120.664743ms","start":"2026-05-06T01:28:20.009815Z","end":"2026-05-06T01:28:20.13048Z","steps":["trace[444980784] 'range keys from in-memory index tree'  (duration: 120.372846ms)"],"step_count":1}