{"level":"warn","ts":"2026-04-08T04:57:00.654111Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-08T04:57:00.65422Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.157:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.157:2380","--initial-cluster=instance=https://199.204.45.157:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.157:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.157: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-04-08T04:57:00.654593Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-08T04:57:00.654613Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.157:2380"]} {"level":"info","ts":"2026-04-08T04:57:00.654659Z","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-04-08T04:57:00.655554Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.157:2379"]} {"level":"info","ts":"2026-04-08T04:57:00.655712Z","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.204.45.157:2380"],"listen-peer-urls":["https://199.204.45.157:2380"],"advertise-client-urls":["https://199.204.45.157:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.157:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.157: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-04-08T04:57:00.660034Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.970069ms"} {"level":"info","ts":"2026-04-08T04:57:00.666647Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"5f170c75a1d97cc","cluster-id":"44a3176ec85feb9"} {"level":"info","ts":"2026-04-08T04:57:00.666778Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc switched to configuration voters=()"} {"level":"info","ts":"2026-04-08T04:57:00.666839Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc became follower at term 0"} {"level":"info","ts":"2026-04-08T04:57:00.666881Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 5f170c75a1d97cc [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-08T04:57:00.666906Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc became follower at term 1"} {"level":"info","ts":"2026-04-08T04:57:00.666987Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc switched to configuration voters=(428247441089599436)"} {"level":"warn","ts":"2026-04-08T04:57:00.673217Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-08T04:57:00.675755Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-08T04:57:00.676909Z","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-04-08T04:57:00.679073Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"5f170c75a1d97cc","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-08T04:57:00.679269Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"5f170c75a1d97cc","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-08T04:57:00.679662Z","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-04-08T04:57:00.680083Z","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-04-08T04:57:00.680102Z","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-04-08T04:57:00.680674Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc switched to configuration voters=(428247441089599436)"} {"level":"info","ts":"2026-04-08T04:57:00.681009Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"44a3176ec85feb9","local-member-id":"5f170c75a1d97cc","added-peer-id":"5f170c75a1d97cc","added-peer-peer-urls":["https://199.204.45.157:2380"]} {"level":"info","ts":"2026-04-08T04:57:00.68364Z","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-04-08T04:57:00.684012Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.157:2380"} {"level":"info","ts":"2026-04-08T04:57:00.684044Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.157:2380"} {"level":"info","ts":"2026-04-08T04:57:00.685161Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"5f170c75a1d97cc","initial-advertise-peer-urls":["https://199.204.45.157:2380"],"listen-peer-urls":["https://199.204.45.157:2380"],"advertise-client-urls":["https://199.204.45.157:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.157:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-08T04:57:00.685227Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-08T04:57:00.967463Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc is starting a new election at term 1"} {"level":"info","ts":"2026-04-08T04:57:00.967571Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc became pre-candidate at term 1"} {"level":"info","ts":"2026-04-08T04:57:00.967806Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc received MsgPreVoteResp from 5f170c75a1d97cc at term 1"} {"level":"info","ts":"2026-04-08T04:57:00.967925Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc became candidate at term 2"} {"level":"info","ts":"2026-04-08T04:57:00.967938Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc received MsgVoteResp from 5f170c75a1d97cc at term 2"} {"level":"info","ts":"2026-04-08T04:57:00.968019Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc became leader at term 2"} {"level":"info","ts":"2026-04-08T04:57:00.968043Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 5f170c75a1d97cc elected leader 5f170c75a1d97cc at term 2"} {"level":"info","ts":"2026-04-08T04:57:00.969094Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"5f170c75a1d97cc","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.157:2379]}","request-path":"/0/members/5f170c75a1d97cc/attributes","cluster-id":"44a3176ec85feb9","publish-timeout":"7s"} {"level":"info","ts":"2026-04-08T04:57:00.969139Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-08T04:57:00.969751Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T04:57:00.969975Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-08T04:57:00.970344Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-08T04:57:00.970424Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-08T04:57:00.970655Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"44a3176ec85feb9","local-member-id":"5f170c75a1d97cc","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T04:57:00.970873Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T04:57:00.970917Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T04:57:00.973231Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.157:2379"} {"level":"info","ts":"2026-04-08T04:57:00.975946Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-08T04:57:06.017382Z","caller":"traceutil/trace.go:171","msg":"trace[1724014256] transaction","detail":"{read_only:false; response_revision:280; number_of_response:1; }","duration":"164.117587ms","start":"2026-04-08T04:57:05.853251Z","end":"2026-04-08T04:57:06.017368Z","steps":["trace[1724014256] 'process raft request' (duration: 163.908198ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T04:57:06.017289Z","caller":"traceutil/trace.go:171","msg":"trace[890453469] transaction","detail":"{read_only:false; response_revision:279; number_of_response:1; }","duration":"165.78909ms","start":"2026-04-08T04:57:05.85144Z","end":"2026-04-08T04:57:06.017229Z","steps":["trace[890453469] 'process raft request' (duration: 92.75512ms)","trace[890453469] 'compare' (duration: 72.841753ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T04:57:06.553665Z","caller":"traceutil/trace.go:171","msg":"trace[921639381] transaction","detail":"{read_only:false; response_revision:287; number_of_response:1; }","duration":"113.738578ms","start":"2026-04-08T04:57:06.439899Z","end":"2026-04-08T04:57:06.553638Z","steps":["trace[921639381] 'process raft request' (duration: 113.613062ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T04:57:06.910214Z","caller":"traceutil/trace.go:171","msg":"trace[1854239709] linearizableReadLoop","detail":"{readStateIndex:300; appliedIndex:299; }","duration":"115.932454ms","start":"2026-04-08T04:57:06.79426Z","end":"2026-04-08T04:57:06.910193Z","steps":["trace[1854239709] 'read index received' (duration: 115.83246ms)","trace[1854239709] 'applied index is now lower than readState.Index' (duration: 99.104µs)"],"step_count":2} {"level":"info","ts":"2026-04-08T04:57:06.910319Z","caller":"traceutil/trace.go:171","msg":"trace[1601992919] transaction","detail":"{read_only:false; response_revision:288; number_of_response:1; }","duration":"148.648837ms","start":"2026-04-08T04:57:06.761644Z","end":"2026-04-08T04:57:06.910292Z","steps":["trace[1601992919] 'process raft request' (duration: 148.426888ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T04:57:06.910469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.161742ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" ","response":"range_response_count:1 size:7111"} {"level":"info","ts":"2026-04-08T04:57:06.910619Z","caller":"traceutil/trace.go:171","msg":"trace[1411734218] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-instance; range_end:; response_count:1; response_revision:288; }","duration":"116.37245ms","start":"2026-04-08T04:57:06.794218Z","end":"2026-04-08T04:57:06.91059Z","steps":["trace[1411734218] 'agreement among raft nodes before linearized reading' (duration: 116.091199ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T04:57:09.675725Z","caller":"traceutil/trace.go:171","msg":"trace[714939530] transaction","detail":"{read_only:false; response_revision:328; number_of_response:1; }","duration":"124.517454ms","start":"2026-04-08T04:57:09.55117Z","end":"2026-04-08T04:57:09.675687Z","steps":["trace[714939530] 'process raft request' (duration: 124.314936ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T04:57:14.729558Z","caller":"traceutil/trace.go:171","msg":"trace[1493607432] transaction","detail":"{read_only:false; response_revision:406; number_of_response:1; }","duration":"105.012147ms","start":"2026-04-08T04:57:14.624516Z","end":"2026-04-08T04:57:14.729528Z","steps":["trace[1493607432] 'process raft request' (duration: 104.835239ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T04:57:29.355859Z","caller":"traceutil/trace.go:171","msg":"trace[303790484] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"148.800923ms","start":"2026-04-08T04:57:29.207009Z","end":"2026-04-08T04:57:29.35581Z","steps":["trace[303790484] 'process raft request' (duration: 86.098943ms)","trace[303790484] 'compare' (duration: 62.46147ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T04:57:29.36255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.336082ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-08T04:57:29.362613Z","caller":"traceutil/trace.go:171","msg":"trace[293124135] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:504; }","duration":"131.484488ms","start":"2026-04-08T04:57:29.231114Z","end":"2026-04-08T04:57:29.362599Z","steps":["trace[293124135] 'agreement among raft nodes before linearized reading' (duration: 131.30403ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T04:57:29.36515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.18178ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/kube-system/cilium\" ","response":"range_response_count:1 size:14401"} {"level":"info","ts":"2026-04-08T04:57:29.365233Z","caller":"traceutil/trace.go:171","msg":"trace[679640655] range","detail":"{range_begin:/registry/daemonsets/kube-system/cilium; range_end:; response_count:1; response_revision:506; }","duration":"158.312235ms","start":"2026-04-08T04:57:29.206897Z","end":"2026-04-08T04:57:29.365209Z","steps":["trace[679640655] 'agreement among raft nodes before linearized reading' (duration: 155.550148ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T04:57:31.830413Z","caller":"traceutil/trace.go:171","msg":"trace[1971077789] transaction","detail":"{read_only:false; response_revision:563; number_of_response:1; }","duration":"515.001601ms","start":"2026-04-08T04:57:31.315378Z","end":"2026-04-08T04:57:31.830379Z","steps":["trace[1971077789] 'process raft request' (duration: 476.534431ms)","trace[1971077789] 'compare' (duration: 37.816862ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T04:57:31.830543Z","caller":"traceutil/trace.go:171","msg":"trace[71868956] linearizableReadLoop","detail":"{readStateIndex:588; appliedIndex:586; }","duration":"469.124975ms","start":"2026-04-08T04:57:31.361392Z","end":"2026-04-08T04:57:31.830517Z","steps":["trace[71868956] 'read index received' (duration: 430.488309ms)","trace[71868956] 'applied index is now lower than readState.Index' (duration: 38.635506ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T04:57:31.830685Z","caller":"traceutil/trace.go:171","msg":"trace[202210930] transaction","detail":"{read_only:false; response_revision:565; number_of_response:1; }","duration":"444.159081ms","start":"2026-04-08T04:57:31.386508Z","end":"2026-04-08T04:57:31.830667Z","steps":["trace[202210930] 'process raft request' (duration: 443.944052ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T04:57:31.830681Z","caller":"traceutil/trace.go:171","msg":"trace[1788334561] transaction","detail":"{read_only:false; response_revision:564; number_of_response:1; }","duration":"511.370786ms","start":"2026-04-08T04:57:31.31927Z","end":"2026-04-08T04:57:31.830641Z","steps":["trace[1788334561] 'process raft request' (duration: 511.060173ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T04:57:31.830825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"469.416177ms","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-04-08T04:57:31.830863Z","caller":"traceutil/trace.go:171","msg":"trace[1394771532] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:565; }","duration":"469.497821ms","start":"2026-04-08T04:57:31.361354Z","end":"2026-04-08T04:57:31.830852Z","steps":["trace[1394771532] 'agreement among raft nodes before linearized reading' (duration: 469.389796ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T04:57:31.830862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"427.762582ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-08T04:57:31.830903Z","caller":"traceutil/trace.go:171","msg":"trace[1538080776] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:565; }","duration":"427.843387ms","start":"2026-04-08T04:57:31.403048Z","end":"2026-04-08T04:57:31.830892Z","steps":["trace[1538080776] 'agreement among raft nodes before linearized reading' (duration: 427.763343ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T04:57:31.830927Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T04:57:31.403032Z","time spent":"427.888778ms","remote":"127.0.0.1:42234","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-08T04:57:31.830895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T04:57:31.361336Z","time spent":"469.550814ms","remote":"127.0.0.1:42234","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-04-08T04:57:31.831084Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T04:57:31.315347Z","time spent":"515.176269ms","remote":"127.0.0.1:42004","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":80688,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T04:57:31.831146Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T04:57:31.319263Z","time spent":"511.493081ms","remote":"127.0.0.1:42004","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":97665,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-08T04:57:31.831305Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T04:57:31.386478Z","time spent":"444.245874ms","remote":"127.0.0.1:42004","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":18032,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T04:57:32.055164Z","caller":"traceutil/trace.go:171","msg":"trace[879885286] transaction","detail":"{read_only:false; response_revision:570; number_of_response:1; }","duration":"169.51774ms","start":"2026-04-08T04:57:31.885625Z","end":"2026-04-08T04:57:32.055142Z","steps":["trace[879885286] 'process raft request' (duration: 169.307051ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T04:57:32.055169Z","caller":"traceutil/trace.go:171","msg":"trace[726186931] transaction","detail":"{read_only:false; response_revision:569; number_of_response:1; }","duration":"170.504143ms","start":"2026-04-08T04:57:31.884625Z","end":"2026-04-08T04:57:32.055129Z","steps":["trace[726186931] 'process raft request' (duration: 137.103876ms)","trace[726186931] 'compare' (duration: 32.99876ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T04:57:32.598816Z","caller":"traceutil/trace.go:171","msg":"trace[312807042] transaction","detail":"{read_only:false; response_revision:571; number_of_response:1; }","duration":"466.831362ms","start":"2026-04-08T04:57:32.131961Z","end":"2026-04-08T04:57:32.598793Z","steps":["trace[312807042] 'process raft request' (duration: 466.659024ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T04:57:32.59895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T04:57:32.131941Z","time spent":"466.938457ms","remote":"127.0.0.1:42004","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":98689,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T04:57:32.646094Z","caller":"traceutil/trace.go:171","msg":"trace[1606433324] transaction","detail":"{read_only:false; response_revision:572; number_of_response:1; }","duration":"498.353999ms","start":"2026-04-08T04:57:32.147706Z","end":"2026-04-08T04:57:32.64606Z","steps":["trace[1606433324] 'process raft request' (duration: 498.073378ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T04:57:32.64614Z","caller":"traceutil/trace.go:171","msg":"trace[1105051202] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"495.743787ms","start":"2026-04-08T04:57:32.150371Z","end":"2026-04-08T04:57:32.646115Z","steps":["trace[1105051202] 'process raft request' (duration: 495.632823ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T04:57:32.646234Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T04:57:32.147688Z","time spent":"498.477724ms","remote":"127.0.0.1:42004","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":73770,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-08T04:57:32.646431Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T04:57:32.150361Z","time spent":"495.842201ms","remote":"127.0.0.1:42004","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":151221,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T04:57:32.791794Z","caller":"traceutil/trace.go:171","msg":"trace[1149741379] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"118.262752ms","start":"2026-04-08T04:57:32.673497Z","end":"2026-04-08T04:57:32.791759Z","steps":["trace[1149741379] 'process raft request' (duration: 81.156857ms)","trace[1149741379] 'compare' (duration: 36.933358ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T04:57:32.85116Z","caller":"traceutil/trace.go:171","msg":"trace[144872930] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"158.604586ms","start":"2026-04-08T04:57:32.69253Z","end":"2026-04-08T04:57:32.851134Z","steps":["trace[144872930] 'process raft request' (duration: 158.481231ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T04:57:32.851168Z","caller":"traceutil/trace.go:171","msg":"trace[1767288333] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"160.313399ms","start":"2026-04-08T04:57:32.690825Z","end":"2026-04-08T04:57:32.851139Z","steps":["trace[1767288333] 'process raft request' (duration: 159.993715ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T04:57:33.051075Z","caller":"traceutil/trace.go:171","msg":"trace[1589871584] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"169.828059ms","start":"2026-04-08T04:57:32.881225Z","end":"2026-04-08T04:57:33.051053Z","steps":["trace[1589871584] 'process raft request' (duration: 138.648735ms)","trace[1589871584] 'compare' (duration: 30.633121ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T04:57:33.051338Z","caller":"traceutil/trace.go:171","msg":"trace[1728166338] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"143.772537ms","start":"2026-04-08T04:57:32.907556Z","end":"2026-04-08T04:57:33.051328Z","steps":["trace[1728166338] 'process raft request' (duration: 143.099078ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T04:57:33.051466Z","caller":"traceutil/trace.go:171","msg":"trace[549910433] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"134.597884ms","start":"2026-04-08T04:57:32.916847Z","end":"2026-04-08T04:57:33.051444Z","steps":["trace[549910433] 'process raft request' (duration: 133.910004ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T04:57:33.809836Z","caller":"traceutil/trace.go:171","msg":"trace[2066171615] linearizableReadLoop","detail":"{readStateIndex:615; appliedIndex:614; }","duration":"106.214727ms","start":"2026-04-08T04:57:33.703556Z","end":"2026-04-08T04:57:33.80977Z","steps":["trace[2066171615] 'read index received' (duration: 70.960048ms)","trace[2066171615] 'applied index is now lower than readState.Index' (duration: 35.252499ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T04:57:33.810126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.549012ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/tcproutes.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:31145"} {"level":"info","ts":"2026-04-08T04:57:33.810177Z","caller":"traceutil/trace.go:171","msg":"trace[1755822257] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/tcproutes.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:591; }","duration":"106.625136ms","start":"2026-04-08T04:57:33.703527Z","end":"2026-04-08T04:57:33.810152Z","steps":["trace[1755822257] 'agreement among raft nodes before linearized reading' (duration: 106.401006ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T04:57:33.810733Z","caller":"traceutil/trace.go:171","msg":"trace[913804929] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"137.975096ms","start":"2026-04-08T04:57:33.672741Z","end":"2026-04-08T04:57:33.810716Z","steps":["trace[913804929] 'process raft request' (duration: 101.859721ms)","trace[913804929] 'compare' (duration: 33.990064ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T04:57:35.346282Z","caller":"traceutil/trace.go:171","msg":"trace[153462154] linearizableReadLoop","detail":"{readStateIndex:622; appliedIndex:621; }","duration":"108.075496ms","start":"2026-04-08T04:57:35.238185Z","end":"2026-04-08T04:57:35.346261Z","steps":["trace[153462154] 'read index received' (duration: 107.891729ms)","trace[153462154] 'applied index is now lower than readState.Index' (duration: 182.727µs)"],"step_count":2} {"level":"info","ts":"2026-04-08T04:57:35.346333Z","caller":"traceutil/trace.go:171","msg":"trace[1936285345] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"287.06091ms","start":"2026-04-08T04:57:35.059244Z","end":"2026-04-08T04:57:35.346305Z","steps":["trace[1936285345] 'process raft request' (duration: 286.886823ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T04:57:35.346459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.261855ms","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-04-08T04:57:35.346497Z","caller":"traceutil/trace.go:171","msg":"trace[51460474] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:597; }","duration":"108.349938ms","start":"2026-04-08T04:57:35.238137Z","end":"2026-04-08T04:57:35.346487Z","steps":["trace[51460474] 'agreement among raft nodes before linearized reading' (duration: 108.212222ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T04:57:35.725766Z","caller":"traceutil/trace.go:171","msg":"trace[901026023] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"375.372586ms","start":"2026-04-08T04:57:35.350365Z","end":"2026-04-08T04:57:35.725738Z","steps":["trace[901026023] 'process raft request' (duration: 372.631458ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T04:57:35.725937Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T04:57:35.350339Z","time spent":"375.510582ms","remote":"127.0.0.1:42234","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T04:57:37.740752Z","caller":"traceutil/trace.go:171","msg":"trace[943064635] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"118.749935ms","start":"2026-04-08T04:57:37.621977Z","end":"2026-04-08T04:57:37.740727Z","steps":["trace[943064635] 'process raft request' (duration: 117.03811ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T04:57:38.215486Z","caller":"traceutil/trace.go:171","msg":"trace[150435829] linearizableReadLoop","detail":"{readStateIndex:638; appliedIndex:637; }","duration":"329.957644ms","start":"2026-04-08T04:57:37.885505Z","end":"2026-04-08T04:57:38.215463Z","steps":["trace[150435829] 'read index received' (duration: 329.818159ms)","trace[150435829] 'applied index is now lower than readState.Index' (duration: 138.575µs)"],"step_count":2} {"level":"info","ts":"2026-04-08T04:57:38.215546Z","caller":"traceutil/trace.go:171","msg":"trace[1478541658] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"399.874471ms","start":"2026-04-08T04:57:37.815649Z","end":"2026-04-08T04:57:38.215523Z","steps":["trace[1478541658] 'process raft request' (duration: 399.671123ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T04:57:38.215649Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T04:57:37.815609Z","time spent":"399.984366ms","remote":"127.0.0.1:42290","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1044,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-08T04:57:38.215726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.207724ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-04-08T04:57:38.215749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.743511ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-08T04:57:38.215748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.457085ms","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-04-08T04:57:38.215768Z","caller":"traceutil/trace.go:171","msg":"trace[1354485734] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:613; }","duration":"195.834635ms","start":"2026-04-08T04:57:38.019927Z","end":"2026-04-08T04:57:38.215762Z","steps":["trace[1354485734] 'agreement among raft nodes before linearized reading' (duration: 195.806644ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T04:57:38.215761Z","caller":"traceutil/trace.go:171","msg":"trace[1185234814] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:613; }","duration":"330.298288ms","start":"2026-04-08T04:57:37.885452Z","end":"2026-04-08T04:57:38.21575Z","steps":["trace[1185234814] 'agreement among raft nodes before linearized reading' (duration: 330.137022ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T04:57:38.21579Z","caller":"traceutil/trace.go:171","msg":"trace[770489265] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:613; }","duration":"298.527698ms","start":"2026-04-08T04:57:37.917252Z","end":"2026-04-08T04:57:38.21578Z","steps":["trace[770489265] 'agreement among raft nodes before linearized reading' (duration: 298.366061ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T04:57:38.2158Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T04:57:37.88543Z","time spent":"330.362641ms","remote":"127.0.0.1:42234","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-08T04:57:39.185335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.348136ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-04-08T04:57:39.185421Z","caller":"traceutil/trace.go:171","msg":"trace[819315809] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:620; }","duration":"219.483272ms","start":"2026-04-08T04:57:38.965918Z","end":"2026-04-08T04:57:39.185402Z","steps":["trace[819315809] 'range keys from in-memory index tree' (duration: 219.237782ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T04:57:39.257727Z","caller":"traceutil/trace.go:171","msg":"trace[172245073] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"177.11699ms","start":"2026-04-08T04:57:39.080568Z","end":"2026-04-08T04:57:39.257685Z","steps":["trace[172245073] 'process raft request' (duration: 176.591827ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T04:57:39.883195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.246574ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-08T04:57:39.883408Z","caller":"traceutil/trace.go:171","msg":"trace[1242139026] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"523.115824ms","start":"2026-04-08T04:57:39.360266Z","end":"2026-04-08T04:57:39.883382Z","steps":["trace[1242139026] 'process raft request' (duration: 415.012383ms)","trace[1242139026] 'compare' (duration: 106.301773ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T04:57:39.883602Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T04:57:39.360226Z","time spent":"523.273721ms","remote":"127.0.0.1:42234","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T04:57:40.035938Z","caller":"traceutil/trace.go:171","msg":"trace[1855319342] linearizableReadLoop","detail":"{readStateIndex:650; appliedIndex:648; }","duration":"284.024922ms","start":"2026-04-08T04:57:39.751889Z","end":"2026-04-08T04:57:40.035914Z","steps":["trace[1855319342] 'read index received' (duration: 23.456405ms)","trace[1855319342] 'applied index is now lower than readState.Index' (duration: 260.567377ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T04:57:40.035977Z","caller":"traceutil/trace.go:171","msg":"trace[511458114] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"288.913454ms","start":"2026-04-08T04:57:39.747029Z","end":"2026-04-08T04:57:40.035943Z","steps":["trace[511458114] 'process raft request' (duration: 246.298506ms)","trace[511458114] 'compare' (duration: 42.280834ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T04:57:40.03616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.249832ms","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-04-08T04:57:40.036199Z","caller":"traceutil/trace.go:171","msg":"trace[349319531] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:624; }","duration":"284.324765ms","start":"2026-04-08T04:57:39.751863Z","end":"2026-04-08T04:57:40.036188Z","steps":["trace[349319531] 'agreement among raft nodes before linearized reading' (duration: 284.180728ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T04:57:40.036585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.052675ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-rpfpt\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-04-08T04:57:40.036621Z","caller":"traceutil/trace.go:171","msg":"trace[1210150059] range","detail":"{range_begin:/registry/pods/kube-system/cilium-rpfpt; range_end:; response_count:1; response_revision:624; }","duration":"206.17294ms","start":"2026-04-08T04:57:39.83044Z","end":"2026-04-08T04:57:40.036613Z","steps":["trace[1210150059] 'agreement among raft nodes before linearized reading' (duration: 205.744182ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T04:57:40.729762Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10938290679799873555,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-08T04:57:41.503481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.359929351s","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-04-08T04:57:41.503595Z","caller":"traceutil/trace.go:171","msg":"trace[156992151] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:625; }","duration":"1.360066508s","start":"2026-04-08T04:57:40.143511Z","end":"2026-04-08T04:57:41.503578Z","steps":["trace[156992151] 'range keys from in-memory index tree' (duration: 1.359909719s)"],"step_count":1} {"level":"warn","ts":"2026-04-08T04:57:41.503778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"608.679832ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-08T04:57:41.504063Z","caller":"traceutil/trace.go:171","msg":"trace[1312981624] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"1.44932752s","start":"2026-04-08T04:57:40.054722Z","end":"2026-04-08T04:57:41.504049Z","steps":["trace[1312981624] 'process raft request' (duration: 840.160687ms)","trace[1312981624] 'compare' (duration: 608.557756ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T04:57:41.504069Z","caller":"traceutil/trace.go:171","msg":"trace[229759129] linearizableReadLoop","detail":"{readStateIndex:653; appliedIndex:651; }","duration":"1.275057579s","start":"2026-04-08T04:57:40.228992Z","end":"2026-04-08T04:57:41.50405Z","steps":["trace[229759129] 'read index received' (duration: 665.916128ms)","trace[229759129] 'applied index is now lower than readState.Index' (duration: 609.140471ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T04:57:41.504217Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T04:57:40.054703Z","time spent":"1.449409842s","remote":"127.0.0.1:42150","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T04:57:41.504242Z","caller":"traceutil/trace.go:171","msg":"trace[1521232030] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"1.408365512s","start":"2026-04-08T04:57:40.095864Z","end":"2026-04-08T04:57:41.50423Z","steps":["trace[1521232030] 'process raft request' (duration: 1.408126181s)"],"step_count":1} {"level":"warn","ts":"2026-04-08T04:57:41.504299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.275294359s","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-04-08T04:57:41.504378Z","caller":"traceutil/trace.go:171","msg":"trace[934297484] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:627; }","duration":"1.275389534s","start":"2026-04-08T04:57:40.228952Z","end":"2026-04-08T04:57:41.504341Z","steps":["trace[934297484] 'agreement among raft nodes before linearized reading' (duration: 1.275283209s)"],"step_count":1} {"level":"warn","ts":"2026-04-08T04:57:41.504335Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T04:57:40.095844Z","time spent":"1.408429585s","remote":"127.0.0.1:42488","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-08T04:57:41.504407Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T04:57:40.228932Z","time spent":"1.275470597s","remote":"127.0.0.1:42234","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-04-08T04:57:41.504586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.295262ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T04:57:41.504606Z","caller":"traceutil/trace.go:171","msg":"trace[2038134674] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:627; }","duration":"101.321253ms","start":"2026-04-08T04:57:41.40328Z","end":"2026-04-08T04:57:41.504601Z","steps":["trace[2038134674] 'agreement among raft nodes before linearized reading' (duration: 101.284921ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T04:57:41.504705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.275368512s","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-04-08T04:57:41.504888Z","caller":"traceutil/trace.go:171","msg":"trace[275250931] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:627; }","duration":"1.275631174s","start":"2026-04-08T04:57:40.229208Z","end":"2026-04-08T04:57:41.50484Z","steps":["trace[275250931] 'agreement among raft nodes before linearized reading' (duration: 1.275116732s)"],"step_count":1} {"level":"warn","ts":"2026-04-08T04:57:41.504986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.49829ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T04:57:41.505098Z","caller":"traceutil/trace.go:171","msg":"trace[1952261629] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:627; }","duration":"153.636526ms","start":"2026-04-08T04:57:41.351448Z","end":"2026-04-08T04:57:41.505084Z","steps":["trace[1952261629] 'agreement among raft nodes before linearized reading' (duration: 153.49217ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T04:57:41.505066Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T04:57:40.229199Z","time spent":"1.275829344s","remote":"127.0.0.1:42234","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-08T04:57:41.505257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.532305ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T04:57:41.507624Z","caller":"traceutil/trace.go:171","msg":"trace[879295329] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:627; }","duration":"156.903847ms","start":"2026-04-08T04:57:41.350682Z","end":"2026-04-08T04:57:41.507586Z","steps":["trace[879295329] 'agreement among raft nodes before linearized reading' (duration: 154.555796ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T04:57:41.505286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"486.448087ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T04:57:41.50774Z","caller":"traceutil/trace.go:171","msg":"trace[679279221] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:627; }","duration":"488.933385ms","start":"2026-04-08T04:57:41.018799Z","end":"2026-04-08T04:57:41.507732Z","steps":["trace[679279221] 'agreement among raft nodes before linearized reading' (duration: 486.477068ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T04:57:41.507794Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T04:57:41.018781Z","time spent":"488.993618ms","remote":"127.0.0.1:41978","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-04-08T04:57:41.505308Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.098616ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T04:57:41.507923Z","caller":"traceutil/trace.go:171","msg":"trace[1575486615] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:627; }","duration":"104.741942ms","start":"2026-04-08T04:57:41.403173Z","end":"2026-04-08T04:57:41.507915Z","steps":["trace[1575486615] 'agreement among raft nodes before linearized reading' (duration: 102.124228ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T04:57:41.50533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.205171ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T04:57:41.510035Z","caller":"traceutil/trace.go:171","msg":"trace[703175201] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:627; }","duration":"106.911256ms","start":"2026-04-08T04:57:41.403108Z","end":"2026-04-08T04:57:41.51002Z","steps":["trace[703175201] 'agreement among raft nodes before linearized reading' (duration: 102.212681ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T04:57:41.505419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.675911ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T04:57:41.510287Z","caller":"traceutil/trace.go:171","msg":"trace[160345238] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:627; }","duration":"159.554203ms","start":"2026-04-08T04:57:41.350719Z","end":"2026-04-08T04:57:41.510273Z","steps":["trace[160345238] 'agreement among raft nodes before linearized reading' (duration: 154.525985ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T04:57:41.949992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.457369ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T04:57:41.950066Z","caller":"traceutil/trace.go:171","msg":"trace[1322848816] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:631; }","duration":"107.601004ms","start":"2026-04-08T04:57:41.84245Z","end":"2026-04-08T04:57:41.950051Z","steps":["trace[1322848816] 'agreement among raft nodes before linearized reading' (duration: 107.460349ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T04:57:41.950146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.74165ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T04:57:41.950214Z","caller":"traceutil/trace.go:171","msg":"trace[2019635981] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:631; }","duration":"107.825776ms","start":"2026-04-08T04:57:41.842373Z","end":"2026-04-08T04:57:41.950198Z","steps":["trace[2019635981] 'agreement among raft nodes before linearized reading' (duration: 107.71903ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T04:57:43.396761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"425.229483ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-08T04:57:43.396758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.475198ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T04:57:43.396835Z","caller":"traceutil/trace.go:171","msg":"trace[1066366864] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:649; }","duration":"425.342258ms","start":"2026-04-08T04:57:42.971478Z","end":"2026-04-08T04:57:43.39682Z","steps":["trace[1066366864] 'range keys from in-memory index tree' (duration: 425.15548ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T04:57:43.396854Z","caller":"traceutil/trace.go:171","msg":"trace[2145634031] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:649; }","duration":"378.660506ms","start":"2026-04-08T04:57:43.018173Z","end":"2026-04-08T04:57:43.396833Z","steps":["trace[2145634031] 'range keys from in-memory index tree' (duration: 378.359793ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T04:57:43.396898Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T04:57:42.971441Z","time spent":"425.417841ms","remote":"127.0.0.1:42050","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":27,"request content":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" "} {"level":"warn","ts":"2026-04-08T04:57:43.396898Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T04:57:43.018156Z","time spent":"378.731978ms","remote":"127.0.0.1:41990","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-04-08T04:57:52.070239Z","caller":"traceutil/trace.go:171","msg":"trace[1438412354] transaction","detail":"{read_only:false; response_revision:753; number_of_response:1; }","duration":"129.482138ms","start":"2026-04-08T04:57:51.94073Z","end":"2026-04-08T04:57:52.070212Z","steps":["trace[1438412354] 'process raft request' (duration: 93.857246ms)","trace[1438412354] 'compare' (duration: 35.147811ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T04:57:52.074461Z","caller":"traceutil/trace.go:171","msg":"trace[1414433178] transaction","detail":"{read_only:false; response_revision:754; number_of_response:1; }","duration":"130.279825ms","start":"2026-04-08T04:57:51.944162Z","end":"2026-04-08T04:57:52.074442Z","steps":["trace[1414433178] 'process raft request' (duration: 129.851525ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T04:57:55.76019Z","caller":"traceutil/trace.go:171","msg":"trace[1603078549] linearizableReadLoop","detail":"{readStateIndex:811; appliedIndex:810; }","duration":"164.456177ms","start":"2026-04-08T04:57:55.59571Z","end":"2026-04-08T04:57:55.760166Z","steps":["trace[1603078549] 'read index received' (duration: 164.356423ms)","trace[1603078549] 'applied index is now lower than readState.Index' (duration: 97.844µs)"],"step_count":2} {"level":"info","ts":"2026-04-08T04:57:55.760334Z","caller":"traceutil/trace.go:171","msg":"trace[388873406] transaction","detail":"{read_only:false; response_revision:780; number_of_response:1; }","duration":"284.072429ms","start":"2026-04-08T04:57:55.476252Z","end":"2026-04-08T04:57:55.760325Z","steps":["trace[388873406] 'process raft request' (duration: 283.688832ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T04:57:55.760683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.9531ms","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-04-08T04:57:55.760752Z","caller":"traceutil/trace.go:171","msg":"trace[1206456341] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:780; }","duration":"165.024183ms","start":"2026-04-08T04:57:55.595693Z","end":"2026-04-08T04:57:55.760717Z","steps":["trace[1206456341] 'agreement among raft nodes before linearized reading' (duration: 164.868356ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T04:57:55.760879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.826062ms","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-04-08T04:57:55.76097Z","caller":"traceutil/trace.go:171","msg":"trace[1294599402] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:780; }","duration":"159.962238ms","start":"2026-04-08T04:57:55.600987Z","end":"2026-04-08T04:57:55.760949Z","steps":["trace[1294599402] 'agreement among raft nodes before linearized reading' (duration: 159.694606ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T04:57:58.256402Z","caller":"traceutil/trace.go:171","msg":"trace[1815806175] linearizableReadLoop","detail":"{readStateIndex:828; appliedIndex:827; }","duration":"238.201152ms","start":"2026-04-08T04:57:58.018188Z","end":"2026-04-08T04:57:58.256389Z","steps":["trace[1815806175] 'read index received' (duration: 237.970701ms)","trace[1815806175] 'applied index is now lower than readState.Index' (duration: 229.631µs)"],"step_count":2} {"level":"info","ts":"2026-04-08T04:57:58.256553Z","caller":"traceutil/trace.go:171","msg":"trace[226344486] transaction","detail":"{read_only:false; response_revision:797; number_of_response:1; }","duration":"310.158682ms","start":"2026-04-08T04:57:57.946376Z","end":"2026-04-08T04:57:58.256535Z","steps":["trace[226344486] 'process raft request' (duration: 309.827347ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T04:57:58.256587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.381269ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T04:57:58.256673Z","caller":"traceutil/trace.go:171","msg":"trace[1342047755] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:797; }","duration":"238.510985ms","start":"2026-04-08T04:57:58.018144Z","end":"2026-04-08T04:57:58.256655Z","steps":["trace[1342047755] 'agreement among raft nodes before linearized reading' (duration: 238.358809ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T04:57:58.256671Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T04:57:57.946357Z","time spent":"310.247016ms","remote":"127.0.0.1:42150","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4028,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T04:58:03.563175Z","caller":"traceutil/trace.go:171","msg":"trace[190580059] transaction","detail":"{read_only:false; response_revision:849; number_of_response:1; }","duration":"128.830972ms","start":"2026-04-08T04:58:03.434083Z","end":"2026-04-08T04:58:03.562914Z","steps":["trace[190580059] 'process raft request' (duration: 128.667445ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T04:58:03.585983Z","caller":"traceutil/trace.go:171","msg":"trace[493168696] linearizableReadLoop","detail":"{readStateIndex:883; appliedIndex:881; }","duration":"143.642661ms","start":"2026-04-08T04:58:03.442316Z","end":"2026-04-08T04:58:03.585958Z","steps":["trace[493168696] 'read index received' (duration: 120.553682ms)","trace[493168696] 'applied index is now lower than readState.Index' (duration: 23.087819ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T04:58:03.586057Z","caller":"traceutil/trace.go:171","msg":"trace[1330560736] transaction","detail":"{read_only:false; response_revision:850; number_of_response:1; }","duration":"150.301209ms","start":"2026-04-08T04:58:03.435735Z","end":"2026-04-08T04:58:03.586036Z","steps":["trace[1330560736] 'process raft request' (duration: 150.059708ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T04:58:03.586374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.010748ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/envoy-gateway-system/\" range_end:\"/registry/serviceaccounts/envoy-gateway-system0\" limit:10000 ","response":"range_response_count:3 size:1862"} {"level":"info","ts":"2026-04-08T04:58:03.586422Z","caller":"traceutil/trace.go:171","msg":"trace[831397923] range","detail":"{range_begin:/registry/serviceaccounts/envoy-gateway-system/; range_end:/registry/serviceaccounts/envoy-gateway-system0; response_count:3; response_revision:850; }","duration":"144.119033ms","start":"2026-04-08T04:58:03.44229Z","end":"2026-04-08T04:58:03.586409Z","steps":["trace[831397923] 'agreement among raft nodes before linearized reading' (duration: 143.84572ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T04:58:18.548016Z","caller":"traceutil/trace.go:171","msg":"trace[479000307] transaction","detail":"{read_only:false; response_revision:1135; number_of_response:1; }","duration":"113.814269ms","start":"2026-04-08T04:58:18.43417Z","end":"2026-04-08T04:58:18.547984Z","steps":["trace[479000307] 'process raft request' (duration: 102.726088ms)","trace[479000307] 'compare' (duration: 10.958076ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T04:58:26.658069Z","caller":"traceutil/trace.go:171","msg":"trace[1075200336] transaction","detail":"{read_only:false; response_revision:1192; number_of_response:1; }","duration":"135.768661ms","start":"2026-04-08T04:58:26.522264Z","end":"2026-04-08T04:58:26.658033Z","steps":["trace[1075200336] 'process raft request' (duration: 135.283277ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T04:58:27.179212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.234295ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-08T04:58:27.179323Z","caller":"traceutil/trace.go:171","msg":"trace[1009078908] linearizableReadLoop","detail":"{readStateIndex:1233; appliedIndex:1232; }","duration":"158.531427ms","start":"2026-04-08T04:58:27.020775Z","end":"2026-04-08T04:58:27.179306Z","steps":["trace[1009078908] 'read index received' (duration: 76.511µs)","trace[1009078908] 'applied index is now lower than readState.Index' (duration: 158.453656ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T04:58:27.179452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.688708ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T04:58:27.179505Z","caller":"traceutil/trace.go:171","msg":"trace[1269731667] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1193; }","duration":"158.799179ms","start":"2026-04-08T04:58:27.020692Z","end":"2026-04-08T04:58:27.179491Z","steps":["trace[1269731667] 'agreement among raft nodes before linearized reading' (duration: 158.666908ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T04:58:27.180487Z","caller":"traceutil/trace.go:171","msg":"trace[259978580] transaction","detail":"{read_only:false; response_revision:1193; number_of_response:1; }","duration":"516.90855ms","start":"2026-04-08T04:58:26.663072Z","end":"2026-04-08T04:58:27.179981Z","steps":["trace[259978580] 'process raft request' (duration: 250.817306ms)","trace[259978580] 'compare' (duration: 265.113564ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T04:58:27.180882Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T04:58:26.663035Z","time spent":"517.659898ms","remote":"127.0.0.1:42234","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T04:58:43.378207Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.029395ms","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-04-08T04:58:43.378319Z","caller":"traceutil/trace.go:171","msg":"trace[595206303] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1331; }","duration":"130.203908ms","start":"2026-04-08T04:58:43.248094Z","end":"2026-04-08T04:58:43.378297Z","steps":["trace[595206303] 'range keys from in-memory index tree' (duration: 129.826211ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T04:58:47.901279Z","caller":"traceutil/trace.go:171","msg":"trace[1661670626] transaction","detail":"{read_only:false; response_revision:1444; number_of_response:1; }","duration":"197.359204ms","start":"2026-04-08T04:58:47.703894Z","end":"2026-04-08T04:58:47.901253Z","steps":["trace[1661670626] 'process raft request' (duration: 197.217891ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T04:58:50.514859Z","caller":"traceutil/trace.go:171","msg":"trace[1767424028] transaction","detail":"{read_only:false; response_revision:1461; number_of_response:1; }","duration":"228.107856ms","start":"2026-04-08T04:58:50.286723Z","end":"2026-04-08T04:58:50.514831Z","steps":["trace[1767424028] 'process raft request' (duration: 227.889172ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T04:59:16.146276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.600925ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-08T04:59:16.146781Z","caller":"traceutil/trace.go:171","msg":"trace[1310724019] transaction","detail":"{read_only:false; response_revision:1883; number_of_response:1; }","duration":"116.204943ms","start":"2026-04-08T04:59:16.030551Z","end":"2026-04-08T04:59:16.146756Z","steps":["trace[1310724019] 'process raft request' (duration: 116.12122ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T04:59:16.147157Z","caller":"traceutil/trace.go:171","msg":"trace[1118674485] transaction","detail":"{read_only:false; response_revision:1882; number_of_response:1; }","duration":"423.564423ms","start":"2026-04-08T04:59:15.72358Z","end":"2026-04-08T04:59:16.147144Z","steps":["trace[1118674485] 'process raft request' (duration: 53.981821ms)","trace[1118674485] 'compare' (duration: 368.44099ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T04:59:16.147368Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T04:59:15.723553Z","time spent":"423.769079ms","remote":"127.0.0.1:42234","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T04:59:16.147824Z","caller":"traceutil/trace.go:171","msg":"trace[830909502] linearizableReadLoop","detail":"{readStateIndex:1958; appliedIndex:1957; }","duration":"413.400398ms","start":"2026-04-08T04:59:15.734391Z","end":"2026-04-08T04:59:16.147791Z","steps":["trace[830909502] 'read index received' (duration: 43.196759ms)","trace[830909502] 'applied index is now lower than readState.Index' (duration: 370.201319ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T04:59:16.148047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.344724ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T04:59:16.148091Z","caller":"traceutil/trace.go:171","msg":"trace[58340640] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1883; }","duration":"128.462677ms","start":"2026-04-08T04:59:16.019618Z","end":"2026-04-08T04:59:16.14808Z","steps":["trace[58340640] 'agreement among raft nodes before linearized reading' (duration: 128.354084ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T04:59:16.148348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"413.942442ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-fd8a0143-0dd9-4b48-aee0-e91b774f9851\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-04-08T04:59:16.14855Z","caller":"traceutil/trace.go:171","msg":"trace[908614447] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-fd8a0143-0dd9-4b48-aee0-e91b774f9851; range_end:; response_count:1; response_revision:1883; }","duration":"414.18355ms","start":"2026-04-08T04:59:15.734345Z","end":"2026-04-08T04:59:16.148528Z","steps":["trace[908614447] 'agreement among raft nodes before linearized reading' (duration: 413.638875ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T04:59:16.148724Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T04:59:15.734326Z","time spent":"414.380405ms","remote":"127.0.0.1:42150","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3649,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-fd8a0143-0dd9-4b48-aee0-e91b774f9851\" "} {"level":"warn","ts":"2026-04-08T04:59:16.829306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"493.199268ms","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-04-08T04:59:16.82932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"498.576655ms","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-04-08T04:59:16.829429Z","caller":"traceutil/trace.go:171","msg":"trace[1618855266] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1883; }","duration":"493.414424ms","start":"2026-04-08T04:59:16.335994Z","end":"2026-04-08T04:59:16.829409Z","steps":["trace[1618855266] 'range keys from in-memory index tree' (duration: 492.827998ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T04:59:16.829467Z","caller":"traceutil/trace.go:171","msg":"trace[1214175557] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1883; }","duration":"498.73472ms","start":"2026-04-08T04:59:16.330691Z","end":"2026-04-08T04:59:16.829426Z","steps":["trace[1214175557] 'range keys from in-memory index tree' (duration: 498.217234ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T04:59:16.829491Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T04:59:16.335967Z","time spent":"493.513346ms","remote":"127.0.0.1:42234","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-04-08T04:59:16.829551Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T04:59:16.330633Z","time spent":"498.905125ms","remote":"127.0.0.1:42234","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-08T04:59:16.829563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"488.132299ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-04-08T04:59:16.829116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.569526ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T04:59:16.829653Z","caller":"traceutil/trace.go:171","msg":"trace[30225760] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1883; }","duration":"488.311495ms","start":"2026-04-08T04:59:16.341318Z","end":"2026-04-08T04:59:16.829629Z","steps":["trace[30225760] 'range keys from in-memory index tree' (duration: 487.84522ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T04:59:16.829671Z","caller":"traceutil/trace.go:171","msg":"trace[1991107648] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:1883; }","duration":"183.188392ms","start":"2026-04-08T04:59:16.646455Z","end":"2026-04-08T04:59:16.829644Z","steps":["trace[1991107648] 'count revisions from in-memory index tree' (duration: 182.465733ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T04:59:16.829715Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T04:59:16.341298Z","time spent":"488.404507ms","remote":"127.0.0.1:42234","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-08T04:59:16.829756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.822411ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T04:59:16.829851Z","caller":"traceutil/trace.go:171","msg":"trace[746778344] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:1883; }","duration":"335.916713ms","start":"2026-04-08T04:59:16.493866Z","end":"2026-04-08T04:59:16.829783Z","steps":["trace[746778344] 'count revisions from in-memory index tree' (duration: 335.588603ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T04:59:16.829851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.815765ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T04:59:16.829896Z","caller":"traceutil/trace.go:171","msg":"trace[1440065821] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:1883; }","duration":"188.908887ms","start":"2026-04-08T04:59:16.640976Z","end":"2026-04-08T04:59:16.829885Z","steps":["trace[1440065821] 'count revisions from in-memory index tree' (duration: 188.706303ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T04:59:16.83017Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T04:59:16.493844Z","time spent":"336.310984ms","remote":"127.0.0.1:54660","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true "} {"level":"warn","ts":"2026-04-08T04:59:16.830521Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"491.931533ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-fd8a0143-0dd9-4b48-aee0-e91b774f9851\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-04-08T04:59:16.830887Z","caller":"traceutil/trace.go:171","msg":"trace[241230497] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-fd8a0143-0dd9-4b48-aee0-e91b774f9851; range_end:; response_count:1; response_revision:1883; }","duration":"492.332235ms","start":"2026-04-08T04:59:16.338532Z","end":"2026-04-08T04:59:16.830864Z","steps":["trace[241230497] 'range keys from in-memory index tree' (duration: 491.745007ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T04:59:16.830973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T04:59:16.338524Z","time spent":"492.431517ms","remote":"127.0.0.1:42150","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3649,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-fd8a0143-0dd9-4b48-aee0-e91b774f9851\" "} {"level":"info","ts":"2026-04-08T04:59:23.219687Z","caller":"traceutil/trace.go:171","msg":"trace[503257433] transaction","detail":"{read_only:false; response_revision:1952; number_of_response:1; }","duration":"124.626016ms","start":"2026-04-08T04:59:23.095027Z","end":"2026-04-08T04:59:23.219653Z","steps":["trace[503257433] 'process raft request' (duration: 82.881146ms)","trace[503257433] 'compare' (duration: 41.609586ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T04:59:29.339308Z","caller":"traceutil/trace.go:171","msg":"trace[1536602388] linearizableReadLoop","detail":"{readStateIndex:2061; appliedIndex:2060; }","duration":"361.886648ms","start":"2026-04-08T04:59:28.977394Z","end":"2026-04-08T04:59:29.33928Z","steps":["trace[1536602388] 'read index received' (duration: 361.741554ms)","trace[1536602388] 'applied index is now lower than readState.Index' (duration: 143.694µs)"],"step_count":2} {"level":"warn","ts":"2026-04-08T04:59:29.33956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"362.147676ms","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-04-08T04:59:29.339597Z","caller":"traceutil/trace.go:171","msg":"trace[1282024382] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1983; }","duration":"362.23779ms","start":"2026-04-08T04:59:28.977347Z","end":"2026-04-08T04:59:29.339585Z","steps":["trace[1282024382] 'agreement among raft nodes before linearized reading' (duration: 362.089485ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T04:59:29.339636Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T04:59:28.977335Z","time spent":"362.292472ms","remote":"127.0.0.1:42234","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-08T04:59:29.339987Z","caller":"traceutil/trace.go:171","msg":"trace[1182914358] transaction","detail":"{read_only:false; response_revision:1983; number_of_response:1; }","duration":"476.163996ms","start":"2026-04-08T04:59:28.863239Z","end":"2026-04-08T04:59:29.339403Z","steps":["trace[1182914358] 'process raft request' (duration: 475.833586ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T04:59:29.34018Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T04:59:28.863206Z","time spent":"476.875438ms","remote":"127.0.0.1:42234","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T04:59:29.343202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"364.785896ms","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-04-08T04:59:29.343222Z","caller":"traceutil/trace.go:171","msg":"trace[283720462] transaction","detail":"{read_only:false; response_revision:1984; number_of_response:1; }","duration":"259.14063ms","start":"2026-04-08T04:59:29.084051Z","end":"2026-04-08T04:59:29.343191Z","steps":["trace[283720462] 'process raft request' (duration: 258.679006ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T04:59:29.343287Z","caller":"traceutil/trace.go:171","msg":"trace[1104532136] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1986; }","duration":"364.904039ms","start":"2026-04-08T04:59:28.978366Z","end":"2026-04-08T04:59:29.34327Z","steps":["trace[1104532136] 'agreement among raft nodes before linearized reading' (duration: 364.631201ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T04:59:29.343334Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T04:59:28.978362Z","time spent":"364.9598ms","remote":"127.0.0.1:42234","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-08T04:59:29.343533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.214771ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:11989"} {"level":"info","ts":"2026-04-08T04:59:29.343565Z","caller":"traceutil/trace.go:171","msg":"trace[1988507351] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:1986; }","duration":"289.247712ms","start":"2026-04-08T04:59:29.054308Z","end":"2026-04-08T04:59:29.343555Z","steps":["trace[1988507351] 'agreement among raft nodes before linearized reading' (duration: 289.116917ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T04:59:29.343604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"363.093136ms","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-04-08T04:59:29.343644Z","caller":"traceutil/trace.go:171","msg":"trace[1358613110] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1986; }","duration":"363.144637ms","start":"2026-04-08T04:59:28.980489Z","end":"2026-04-08T04:59:29.343633Z","steps":["trace[1358613110] 'agreement among raft nodes before linearized reading' (duration: 363.043354ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T04:59:29.343676Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T04:59:28.980483Z","time spent":"363.186078ms","remote":"127.0.0.1:42234","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-04-08T04:59:29.34377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.856487ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T04:59:29.343794Z","caller":"traceutil/trace.go:171","msg":"trace[478946340] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1986; }","duration":"324.901007ms","start":"2026-04-08T04:59:29.018885Z","end":"2026-04-08T04:59:29.343786Z","steps":["trace[478946340] 'agreement among raft nodes before linearized reading' (duration: 324.864506ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T04:59:29.343822Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T04:59:29.018872Z","time spent":"324.945569ms","remote":"127.0.0.1:41978","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-04-08T04:59:29.343843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"364.116126ms","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-04-08T04:59:29.343937Z","caller":"traceutil/trace.go:171","msg":"trace[691000703] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1986; }","duration":"364.238499ms","start":"2026-04-08T04:59:28.979688Z","end":"2026-04-08T04:59:29.343927Z","steps":["trace[691000703] 'agreement among raft nodes before linearized reading' (duration: 364.065124ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T04:59:29.343966Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T04:59:28.979682Z","time spent":"364.27655ms","remote":"127.0.0.1:42234","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-04-08T04:59:45.611271Z","caller":"traceutil/trace.go:171","msg":"trace[1155727624] linearizableReadLoop","detail":"{readStateIndex:2175; appliedIndex:2174; }","duration":"153.676808ms","start":"2026-04-08T04:59:45.457547Z","end":"2026-04-08T04:59:45.611224Z","steps":["trace[1155727624] 'read index received' (duration: 151.167967ms)","trace[1155727624] 'applied index is now lower than readState.Index' (duration: 2.507591ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T04:59:45.611392Z","caller":"traceutil/trace.go:171","msg":"trace[1760405193] transaction","detail":"{read_only:false; response_revision:2093; number_of_response:1; }","duration":"159.746625ms","start":"2026-04-08T04:59:45.451633Z","end":"2026-04-08T04:59:45.61138Z","steps":["trace[1760405193] 'process raft request' (duration: 157.016787ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T04:59:45.61192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.404121ms","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-04-08T04:59:45.611974Z","caller":"traceutil/trace.go:171","msg":"trace[2121416215] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2093; }","duration":"158.489995ms","start":"2026-04-08T04:59:45.453469Z","end":"2026-04-08T04:59:45.611959Z","steps":["trace[2121416215] 'agreement among raft nodes before linearized reading' (duration: 158.132603ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T04:59:45.614477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.451753ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-04-08T04:59:45.614519Z","caller":"traceutil/trace.go:171","msg":"trace[1699362975] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2094; }","duration":"142.512456ms","start":"2026-04-08T04:59:45.471995Z","end":"2026-04-08T04:59:45.614507Z","steps":["trace[1699362975] 'agreement among raft nodes before linearized reading' (duration: 142.409492ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T04:59:45.614566Z","caller":"traceutil/trace.go:171","msg":"trace[330037102] transaction","detail":"{read_only:false; response_revision:2094; number_of_response:1; }","duration":"154.064482ms","start":"2026-04-08T04:59:45.460467Z","end":"2026-04-08T04:59:45.614532Z","steps":["trace[330037102] 'process raft request' (duration: 153.868675ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T04:59:52.050449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.19429ms","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-04-08T04:59:52.050538Z","caller":"traceutil/trace.go:171","msg":"trace[1185888939] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2128; }","duration":"300.332755ms","start":"2026-04-08T04:59:51.750183Z","end":"2026-04-08T04:59:52.050516Z","steps":["trace[1185888939] 'range keys from in-memory index tree' (duration: 299.966153ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T04:59:52.050586Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T04:59:51.750167Z","time spent":"300.408239ms","remote":"127.0.0.1:42234","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-04-08T04:59:52.70066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.363457ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-08T04:59:52.701398Z","caller":"traceutil/trace.go:171","msg":"trace[1138482455] range","detail":"{range_begin:/registry/deployments/; range_end:/registry/deployments0; response_count:0; response_revision:2130; }","duration":"153.190325ms","start":"2026-04-08T04:59:52.548186Z","end":"2026-04-08T04:59:52.701376Z","steps":["trace[1138482455] 'count revisions from in-memory index tree' (duration: 152.195041ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:00:50.565557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"507.273728ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-04-08T05:00:50.565679Z","caller":"traceutil/trace.go:171","msg":"trace[739646327] linearizableReadLoop","detail":"{readStateIndex:2574; appliedIndex:2573; }","duration":"990.080053ms","start":"2026-04-08T05:00:49.575578Z","end":"2026-04-08T05:00:50.565658Z","steps":["trace[739646327] 'read index received' (duration: 482.835976ms)","trace[739646327] 'applied index is now lower than readState.Index' (duration: 507.242557ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T05:00:50.566216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"990.618095ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:559"} {"level":"info","ts":"2026-04-08T05:00:50.566313Z","caller":"traceutil/trace.go:171","msg":"trace[715265885] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:2477; }","duration":"990.77484ms","start":"2026-04-08T05:00:49.575514Z","end":"2026-04-08T05:00:50.566288Z","steps":["trace[715265885] 'agreement among raft nodes before linearized reading' (duration: 990.412746ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:00:50.566461Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:00:49.575488Z","time spent":"990.960317ms","remote":"127.0.0.1:42234","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":581,"request content":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" "} {"level":"warn","ts":"2026-04-08T05:00:50.586834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"669.254497ms","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-04-08T05:00:50.586928Z","caller":"traceutil/trace.go:171","msg":"trace[49330511] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2480; }","duration":"669.361821ms","start":"2026-04-08T05:00:49.917551Z","end":"2026-04-08T05:00:50.586913Z","steps":["trace[49330511] 'agreement among raft nodes before linearized reading' (duration: 669.116251ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:00:50.586907Z","caller":"traceutil/trace.go:171","msg":"trace[1352013128] transaction","detail":"{read_only:false; response_revision:2479; number_of_response:1; }","duration":"786.770856ms","start":"2026-04-08T05:00:49.800101Z","end":"2026-04-08T05:00:50.586872Z","steps":["trace[1352013128] 'process raft request' (duration: 786.476115ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:00:50.586975Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:00:49.917518Z","time spent":"669.449434ms","remote":"127.0.0.1:42234","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-04-08T05:00:50.586929Z","caller":"traceutil/trace.go:171","msg":"trace[340054180] transaction","detail":"{read_only:false; response_revision:2480; number_of_response:1; }","duration":"734.861798ms","start":"2026-04-08T05:00:49.85204Z","end":"2026-04-08T05:00:50.586901Z","steps":["trace[340054180] 'process raft request' (duration: 734.585396ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:00:50.587092Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:00:49.800089Z","time spent":"786.902181ms","remote":"127.0.0.1:42234","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T05:00:50.587136Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:00:49.852007Z","time spent":"735.045385ms","remote":"127.0.0.1:42234","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T05:00:50.587234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.029356ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T05:00:50.587284Z","caller":"traceutil/trace.go:171","msg":"trace[1642294107] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:2481; }","duration":"307.074058ms","start":"2026-04-08T05:00:50.280192Z","end":"2026-04-08T05:00:50.587266Z","steps":["trace[1642294107] 'agreement among raft nodes before linearized reading' (duration: 306.990435ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:00:50.587344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"616.369122ms","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-04-08T05:00:50.587386Z","caller":"traceutil/trace.go:171","msg":"trace[218606973] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2481; }","duration":"616.429034ms","start":"2026-04-08T05:00:49.970944Z","end":"2026-04-08T05:00:50.587373Z","steps":["trace[218606973] 'agreement among raft nodes before linearized reading' (duration: 616.283899ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:00:50.587421Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:00:49.970934Z","time spent":"616.480436ms","remote":"127.0.0.1:42234","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-04-08T05:00:50.587343Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:00:50.280135Z","time spent":"307.195173ms","remote":"127.0.0.1:58974","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true "} {"level":"warn","ts":"2026-04-08T05:00:50.587455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"575.576607ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-04-08T05:00:50.587394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"570.036613ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T05:00:50.587482Z","caller":"traceutil/trace.go:171","msg":"trace[459435960] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2481; }","duration":"575.646349ms","start":"2026-04-08T05:00:50.011826Z","end":"2026-04-08T05:00:50.587473Z","steps":["trace[459435960] 'agreement among raft nodes before linearized reading' (duration: 575.584506ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:00:50.587499Z","caller":"traceutil/trace.go:171","msg":"trace[1070602502] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2481; }","duration":"570.147739ms","start":"2026-04-08T05:00:50.017341Z","end":"2026-04-08T05:00:50.587489Z","steps":["trace[1070602502] 'agreement among raft nodes before linearized reading' (duration: 570.030534ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:00:50.587512Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:00:50.011802Z","time spent":"575.705771ms","remote":"127.0.0.1:42234","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-08T05:00:50.587527Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:00:50.017332Z","time spent":"570.18931ms","remote":"127.0.0.1:41978","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-04-08T05:00:50.587496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.800702ms","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-04-08T05:00:50.58767Z","caller":"traceutil/trace.go:171","msg":"trace[737002624] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2480; }","duration":"201.121835ms","start":"2026-04-08T05:00:50.386533Z","end":"2026-04-08T05:00:50.587654Z","steps":["trace[737002624] 'agreement among raft nodes before linearized reading' (duration: 200.301074ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:00:50.58735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"578.103942ms","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-04-08T05:00:50.589114Z","caller":"traceutil/trace.go:171","msg":"trace[851436761] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2481; }","duration":"579.89082ms","start":"2026-04-08T05:00:50.009202Z","end":"2026-04-08T05:00:50.589092Z","steps":["trace[851436761] 'agreement among raft nodes before linearized reading' (duration: 577.998228ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:00:50.589212Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:00:50.009185Z","time spent":"579.975484ms","remote":"127.0.0.1:42234","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-04-08T05:00:50.587859Z","caller":"traceutil/trace.go:171","msg":"trace[507179231] transaction","detail":"{read_only:false; response_revision:2478; number_of_response:1; }","duration":"788.714699ms","start":"2026-04-08T05:00:49.799127Z","end":"2026-04-08T05:00:50.587842Z","steps":["trace[507179231] 'process raft request' (duration: 787.284535ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:00:50.589467Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:00:49.799082Z","time spent":"790.339271ms","remote":"127.0.0.1:42234","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T05:00:51.558802Z","caller":"traceutil/trace.go:171","msg":"trace[1703987029] transaction","detail":"{read_only:false; response_revision:2489; number_of_response:1; }","duration":"506.627211ms","start":"2026-04-08T05:00:51.052149Z","end":"2026-04-08T05:00:51.558776Z","steps":["trace[1703987029] 'process raft request' (duration: 506.165053ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:00:51.558945Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:00:51.052126Z","time spent":"506.747885ms","remote":"127.0.0.1:42234","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T05:01:01.981727Z","caller":"traceutil/trace.go:171","msg":"trace[1512572900] transaction","detail":"{read_only:false; response_revision:2585; number_of_response:1; }","duration":"141.265373ms","start":"2026-04-08T05:01:01.840437Z","end":"2026-04-08T05:01:01.981702Z","steps":["trace[1512572900] 'process raft request' (duration: 141.069725ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:01:02.481612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.719942ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusterrestores/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterrestores0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T05:01:02.482291Z","caller":"traceutil/trace.go:171","msg":"trace[668013986] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusterrestores/; range_end:/registry/pxc.percona.com/perconaxtradbclusterrestores0; response_count:0; response_revision:2585; }","duration":"309.445819ms","start":"2026-04-08T05:01:02.172811Z","end":"2026-04-08T05:01:02.482257Z","steps":["trace[668013986] 'count revisions from in-memory index tree' (duration: 308.567646ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:01:02.482533Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:01:02.17279Z","time spent":"309.656677ms","remote":"127.0.0.1:44174","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":27,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusterrestores/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterrestores0\" count_only:true "} {"level":"warn","ts":"2026-04-08T05:01:02.483174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.658633ms","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-04-08T05:01:02.483256Z","caller":"traceutil/trace.go:171","msg":"trace[1413326627] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:2585; }","duration":"204.810698ms","start":"2026-04-08T05:01:02.278425Z","end":"2026-04-08T05:01:02.483236Z","steps":["trace[1413326627] 'count revisions from in-memory index tree' (duration: 203.498408ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:01:37.035111Z","caller":"traceutil/trace.go:171","msg":"trace[283879125] transaction","detail":"{read_only:false; response_revision:2791; number_of_response:1; }","duration":"234.05893ms","start":"2026-04-08T05:01:36.801036Z","end":"2026-04-08T05:01:37.035095Z","steps":["trace[283879125] 'process raft request' (duration: 233.840741ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:01:37.762645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"411.512393ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-08T05:01:37.76374Z","caller":"traceutil/trace.go:171","msg":"trace[641872609] transaction","detail":"{read_only:false; response_revision:2792; number_of_response:1; }","duration":"959.366232ms","start":"2026-04-08T05:01:36.804344Z","end":"2026-04-08T05:01:37.763711Z","steps":["trace[641872609] 'process raft request' (duration: 546.674733ms)","trace[641872609] 'compare' (duration: 411.034153ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T05:01:37.763973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:01:36.804316Z","time spent":"959.590382ms","remote":"127.0.0.1:42234","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T05:01:37.763758Z","caller":"traceutil/trace.go:171","msg":"trace[912085320] transaction","detail":"{read_only:false; response_revision:2793; number_of_response:1; }","duration":"957.250328ms","start":"2026-04-08T05:01:36.80648Z","end":"2026-04-08T05:01:37.76373Z","steps":["trace[912085320] 'process raft request' (duration: 956.27833ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:01:37.76458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"896.77393ms","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-04-08T05:01:37.764625Z","caller":"traceutil/trace.go:171","msg":"trace[1201085611] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2794; }","duration":"896.834593ms","start":"2026-04-08T05:01:36.867781Z","end":"2026-04-08T05:01:37.764616Z","steps":["trace[1201085611] 'agreement among raft nodes before linearized reading' (duration: 896.677616ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:01:37.76465Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:01:36.867747Z","time spent":"896.898165ms","remote":"127.0.0.1:42234","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":"warn","ts":"2026-04-08T05:01:37.7646Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:01:36.806472Z","time spent":"958.051119ms","remote":"127.0.0.1:42234","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T05:01:37.764182Z","caller":"traceutil/trace.go:171","msg":"trace[1617943730] transaction","detail":"{read_only:false; response_revision:2794; number_of_response:1; }","duration":"924.732734ms","start":"2026-04-08T05:01:36.839418Z","end":"2026-04-08T05:01:37.764151Z","steps":["trace[1617943730] 'process raft request' (duration: 924.257865ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:01:37.76524Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:01:36.839396Z","time spent":"925.797525ms","remote":"127.0.0.1:42234","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T05:01:37.764416Z","caller":"traceutil/trace.go:171","msg":"trace[907307102] linearizableReadLoop","detail":"{readStateIndex:2901; appliedIndex:2897; }","duration":"896.599573ms","start":"2026-04-08T05:01:36.867788Z","end":"2026-04-08T05:01:37.764388Z","steps":["trace[907307102] 'read index received' (duration: 167.251029ms)","trace[907307102] 'applied index is now lower than readState.Index' (duration: 729.343294ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T05:01:37.76544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"896.978958ms","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-04-08T05:01:37.76546Z","caller":"traceutil/trace.go:171","msg":"trace[694588901] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2794; }","duration":"897.014861ms","start":"2026-04-08T05:01:36.86844Z","end":"2026-04-08T05:01:37.765454Z","steps":["trace[694588901] 'agreement among raft nodes before linearized reading' (duration: 896.946078ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:01:37.765474Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:01:36.868432Z","time spent":"897.038952ms","remote":"127.0.0.1:42234","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-04-08T05:01:37.765544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.130258ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-08T05:01:37.765562Z","caller":"traceutil/trace.go:171","msg":"trace[1242818910] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:2794; }","duration":"345.204951ms","start":"2026-04-08T05:01:37.420351Z","end":"2026-04-08T05:01:37.765556Z","steps":["trace[1242818910] 'agreement among raft nodes before linearized reading' (duration: 345.160359ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:01:37.765576Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:01:37.42033Z","time spent":"345.242553ms","remote":"127.0.0.1:42276","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":5,"response size":29,"request content":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true "} {"level":"warn","ts":"2026-04-08T05:01:37.765675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"744.962646ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-08T05:01:37.765761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"892.715519ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-08T05:01:37.765791Z","caller":"traceutil/trace.go:171","msg":"trace[1677717621] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2794; }","duration":"892.75303ms","start":"2026-04-08T05:01:36.873029Z","end":"2026-04-08T05:01:37.765782Z","steps":["trace[1677717621] 'agreement among raft nodes before linearized reading' (duration: 892.692597ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:01:37.765813Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:01:36.873023Z","time spent":"892.785632ms","remote":"127.0.0.1:42234","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-08T05:01:37.765756Z","caller":"traceutil/trace.go:171","msg":"trace[1686092707] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2794; }","duration":"745.156684ms","start":"2026-04-08T05:01:37.020578Z","end":"2026-04-08T05:01:37.765735Z","steps":["trace[1686092707] 'agreement among raft nodes before linearized reading' (duration: 744.954386ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:01:37.766074Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:01:37.020557Z","time spent":"745.501277ms","remote":"127.0.0.1:41978","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-04-08T05:01:37.76571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"877.013034ms","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-04-08T05:01:37.766136Z","caller":"traceutil/trace.go:171","msg":"trace[1737059808] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2794; }","duration":"877.483573ms","start":"2026-04-08T05:01:36.888644Z","end":"2026-04-08T05:01:37.766127Z","steps":["trace[1737059808] 'agreement among raft nodes before linearized reading' (duration: 877.023404ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:01:37.766164Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:01:36.888621Z","time spent":"877.536335ms","remote":"127.0.0.1:42234","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-08T05:01:37.765907Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"896.889375ms","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-04-08T05:01:37.76622Z","caller":"traceutil/trace.go:171","msg":"trace[155123348] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2794; }","duration":"897.215328ms","start":"2026-04-08T05:01:36.869Z","end":"2026-04-08T05:01:37.766216Z","steps":["trace[155123348] 'agreement among raft nodes before linearized reading' (duration: 896.866644ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:01:37.766236Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:01:36.868995Z","time spent":"897.237479ms","remote":"127.0.0.1:42234","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-04-08T05:01:37.766432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"419.754ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-04-08T05:01:37.766454Z","caller":"traceutil/trace.go:171","msg":"trace[1671063597] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2794; }","duration":"419.835143ms","start":"2026-04-08T05:01:37.346614Z","end":"2026-04-08T05:01:37.766449Z","steps":["trace[1671063597] 'agreement among raft nodes before linearized reading' (duration: 419.75735ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:01:37.766472Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:01:37.346575Z","time spent":"419.892347ms","remote":"127.0.0.1:42150","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12238,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-04-08T05:01:37.766742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"738.354163ms","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-04-08T05:01:37.766773Z","caller":"traceutil/trace.go:171","msg":"trace[110384039] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2794; }","duration":"738.398575ms","start":"2026-04-08T05:01:37.028367Z","end":"2026-04-08T05:01:37.766766Z","steps":["trace[110384039] 'agreement among raft nodes before linearized reading' (duration: 737.715768ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:01:37.766792Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:01:37.028343Z","time spent":"738.444656ms","remote":"127.0.0.1:42160","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":1391,"request content":"key:\"/registry/services/specs/auth-system/keycloak-headless\" "} {"level":"info","ts":"2026-04-08T05:01:38.022112Z","caller":"traceutil/trace.go:171","msg":"trace[1868789348] transaction","detail":"{read_only:false; response_revision:2799; number_of_response:1; }","duration":"250.110623ms","start":"2026-04-08T05:01:37.771983Z","end":"2026-04-08T05:01:38.022094Z","steps":["trace[1868789348] 'process raft request' (duration: 250.087352ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:01:38.022348Z","caller":"traceutil/trace.go:171","msg":"trace[1916109855] transaction","detail":"{read_only:false; response_revision:2795; number_of_response:1; }","duration":"253.125865ms","start":"2026-04-08T05:01:37.769215Z","end":"2026-04-08T05:01:38.022341Z","steps":["trace[1916109855] 'process raft request' (duration: 246.966389ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:01:38.022446Z","caller":"traceutil/trace.go:171","msg":"trace[115532394] linearizableReadLoop","detail":"{readStateIndex:2902; appliedIndex:2901; }","duration":"252.408895ms","start":"2026-04-08T05:01:37.770031Z","end":"2026-04-08T05:01:38.022439Z","steps":["trace[115532394] 'read index received' (duration: 246.168407ms)","trace[115532394] 'applied index is now lower than readState.Index' (duration: 6.239858ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T05:01:38.022503Z","caller":"traceutil/trace.go:171","msg":"trace[1585161924] transaction","detail":"{read_only:false; response_revision:2796; number_of_response:1; }","duration":"251.775211ms","start":"2026-04-08T05:01:37.770723Z","end":"2026-04-08T05:01:38.022498Z","steps":["trace[1585161924] 'process raft request' (duration: 251.279131ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:01:38.022576Z","caller":"traceutil/trace.go:171","msg":"trace[1635314721] transaction","detail":"{read_only:false; response_revision:2797; number_of_response:1; }","duration":"251.426906ms","start":"2026-04-08T05:01:37.771144Z","end":"2026-04-08T05:01:38.022571Z","steps":["trace[1635314721] 'process raft request' (duration: 250.884805ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:01:38.022656Z","caller":"traceutil/trace.go:171","msg":"trace[1902259987] transaction","detail":"{read_only:false; response_revision:2798; number_of_response:1; }","duration":"251.379124ms","start":"2026-04-08T05:01:37.771271Z","end":"2026-04-08T05:01:38.022651Z","steps":["trace[1902259987] 'process raft request' (duration: 250.7765ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:01:38.023224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.163925ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-metrics\" ","response":"range_response_count:1 size:1445"} {"level":"info","ts":"2026-04-08T05:01:38.023302Z","caller":"traceutil/trace.go:171","msg":"trace[155653037] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-metrics; range_end:; response_count:1; response_revision:2799; }","duration":"253.27106ms","start":"2026-04-08T05:01:37.770009Z","end":"2026-04-08T05:01:38.02328Z","steps":["trace[155653037] 'agreement among raft nodes before linearized reading' (duration: 252.976668ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:01:38.024539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.618323ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-04-08T05:01:38.024578Z","caller":"traceutil/trace.go:171","msg":"trace[971396569] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2799; }","duration":"253.693936ms","start":"2026-04-08T05:01:37.770875Z","end":"2026-04-08T05:01:38.024569Z","steps":["trace[971396569] 'agreement among raft nodes before linearized reading' (duration: 253.565501ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:01:38.024855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.788377ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/queues/\" range_end:\"/registry/rabbitmq.com/queues0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T05:01:38.024884Z","caller":"traceutil/trace.go:171","msg":"trace[1989819669] range","detail":"{range_begin:/registry/rabbitmq.com/queues/; range_end:/registry/rabbitmq.com/queues0; response_count:0; response_revision:2799; }","duration":"154.850029ms","start":"2026-04-08T05:01:37.870027Z","end":"2026-04-08T05:01:38.024877Z","steps":["trace[1989819669] 'agreement among raft nodes before linearized reading' (duration: 154.805177ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:02:48.640387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.924295ms","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-04-08T05:02:48.640516Z","caller":"traceutil/trace.go:171","msg":"trace[1238935218] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:3165; }","duration":"162.142206ms","start":"2026-04-08T05:02:48.478349Z","end":"2026-04-08T05:02:48.640491Z","steps":["trace[1238935218] 'range keys from in-memory index tree' (duration: 161.715454ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:03:36.514231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.182409ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-08T05:03:36.514445Z","caller":"traceutil/trace.go:171","msg":"trace[1109665827] linearizableReadLoop","detail":"{readStateIndex:3634; appliedIndex:3632; }","duration":"231.271006ms","start":"2026-04-08T05:03:36.283149Z","end":"2026-04-08T05:03:36.51442Z","steps":["trace[1109665827] 'read index received' (duration: 9.565032ms)","trace[1109665827] 'applied index is now lower than readState.Index' (duration: 221.703944ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T05:03:36.514675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.51717ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T05:03:36.514665Z","caller":"traceutil/trace.go:171","msg":"trace[1019548134] transaction","detail":"{read_only:false; response_revision:3499; number_of_response:1; }","duration":"233.300387ms","start":"2026-04-08T05:03:36.281297Z","end":"2026-04-08T05:03:36.514597Z","steps":["trace[1019548134] 'process raft request' (duration: 90.63949ms)","trace[1019548134] 'compare' (duration: 141.720952ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T05:03:36.51476Z","caller":"traceutil/trace.go:171","msg":"trace[756369020] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:3499; }","duration":"231.632992ms","start":"2026-04-08T05:03:36.283113Z","end":"2026-04-08T05:03:36.514746Z","steps":["trace[756369020] 'agreement among raft nodes before linearized reading' (duration: 231.50977ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:03:36.596444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.776571ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T05:03:36.596597Z","caller":"traceutil/trace.go:171","msg":"trace[1717671097] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:3500; }","duration":"161.979364ms","start":"2026-04-08T05:03:36.434599Z","end":"2026-04-08T05:03:36.596578Z","steps":["trace[1717671097] 'agreement among raft nodes before linearized reading' (duration: 161.772421ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:03:36.596438Z","caller":"traceutil/trace.go:171","msg":"trace[910981001] transaction","detail":"{read_only:false; response_revision:3500; number_of_response:1; }","duration":"137.236951ms","start":"2026-04-08T05:03:36.459167Z","end":"2026-04-08T05:03:36.596404Z","steps":["trace[910981001] 'process raft request' (duration: 137.064317ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:03:37.167436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.680342ms","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-04-08T05:03:37.167508Z","caller":"traceutil/trace.go:171","msg":"trace[147013835] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:3501; }","duration":"139.767314ms","start":"2026-04-08T05:03:37.027723Z","end":"2026-04-08T05:03:37.16749Z","steps":["trace[147013835] 'range keys from in-memory index tree' (duration: 139.564811ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:03:37.167741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.832714ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-08T05:03:37.16773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.32999ms","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-04-08T05:03:37.167829Z","caller":"traceutil/trace.go:171","msg":"trace[858312233] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:3501; }","duration":"123.445862ms","start":"2026-04-08T05:03:37.044374Z","end":"2026-04-08T05:03:37.16782Z","steps":["trace[858312233] 'range keys from in-memory index tree' (duration: 123.242159ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:03:37.167787Z","caller":"traceutil/trace.go:171","msg":"trace[433138294] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:3501; }","duration":"147.934386ms","start":"2026-04-08T05:03:37.019839Z","end":"2026-04-08T05:03:37.167773Z","steps":["trace[433138294] 'range keys from in-memory index tree' (duration: 147.744313ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:03:37.167931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.304969ms","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-04-08T05:03:37.167993Z","caller":"traceutil/trace.go:171","msg":"trace[1212645684] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:3501; }","duration":"123.373341ms","start":"2026-04-08T05:03:37.044612Z","end":"2026-04-08T05:03:37.167985Z","steps":["trace[1212645684] 'range keys from in-memory index tree' (duration: 123.244269ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:03:37.293538Z","caller":"traceutil/trace.go:171","msg":"trace[2081612699] transaction","detail":"{read_only:false; response_revision:3502; number_of_response:1; }","duration":"121.931398ms","start":"2026-04-08T05:03:37.171581Z","end":"2026-04-08T05:03:37.293512Z","steps":["trace[2081612699] 'process raft request' (duration: 121.792296ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:03:37.350357Z","caller":"traceutil/trace.go:171","msg":"trace[480656688] transaction","detail":"{read_only:false; response_revision:3504; number_of_response:1; }","duration":"178.165801ms","start":"2026-04-08T05:03:37.172172Z","end":"2026-04-08T05:03:37.350338Z","steps":["trace[480656688] 'process raft request' (duration: 177.858556ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:03:37.350603Z","caller":"traceutil/trace.go:171","msg":"trace[374019606] transaction","detail":"{read_only:false; response_revision:3503; number_of_response:1; }","duration":"178.76614ms","start":"2026-04-08T05:03:37.17183Z","end":"2026-04-08T05:03:37.350596Z","steps":["trace[374019606] 'process raft request' (duration: 178.088159ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:03:37.350576Z","caller":"traceutil/trace.go:171","msg":"trace[1255989814] transaction","detail":"{read_only:false; response_revision:3505; number_of_response:1; }","duration":"178.07625ms","start":"2026-04-08T05:03:37.172473Z","end":"2026-04-08T05:03:37.35055Z","steps":["trace[1255989814] 'process raft request' (duration: 177.586662ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:03:56.925804Z","caller":"traceutil/trace.go:171","msg":"trace[258722962] linearizableReadLoop","detail":"{readStateIndex:3756; appliedIndex:3755; }","duration":"165.349967ms","start":"2026-04-08T05:03:56.76043Z","end":"2026-04-08T05:03:56.92578Z","steps":["trace[258722962] 'read index received' (duration: 165.124303ms)","trace[258722962] 'applied index is now lower than readState.Index' (duration: 224.674µs)"],"step_count":2} {"level":"warn","ts":"2026-04-08T05:03:56.925968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.519529ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T05:03:56.926011Z","caller":"traceutil/trace.go:171","msg":"trace[1127454400] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:3617; }","duration":"165.621161ms","start":"2026-04-08T05:03:56.760378Z","end":"2026-04-08T05:03:56.926Z","steps":["trace[1127454400] 'agreement among raft nodes before linearized reading' (duration: 165.505669ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:03:56.926235Z","caller":"traceutil/trace.go:171","msg":"trace[1280686266] transaction","detail":"{read_only:false; response_revision:3617; number_of_response:1; }","duration":"245.795503ms","start":"2026-04-08T05:03:56.680401Z","end":"2026-04-08T05:03:56.926197Z","steps":["trace[1280686266] 'process raft request' (duration: 245.248572ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:04:48.977615Z","caller":"traceutil/trace.go:171","msg":"trace[695779657] transaction","detail":"{read_only:false; response_revision:3963; number_of_response:1; }","duration":"116.515558ms","start":"2026-04-08T05:04:48.861069Z","end":"2026-04-08T05:04:48.977584Z","steps":["trace[695779657] 'process raft request' (duration: 65.320516ms)","trace[695779657] 'compare' (duration: 50.925796ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T05:05:09.346376Z","caller":"traceutil/trace.go:171","msg":"trace[590449307] transaction","detail":"{read_only:false; response_revision:4071; number_of_response:1; }","duration":"102.657867ms","start":"2026-04-08T05:05:09.243684Z","end":"2026-04-08T05:05:09.346341Z","steps":["trace[590449307] 'process raft request' (duration: 102.333209ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:05:13.920898Z","caller":"traceutil/trace.go:171","msg":"trace[1853354724] transaction","detail":"{read_only:false; response_revision:4118; number_of_response:1; }","duration":"392.737626ms","start":"2026-04-08T05:05:13.528142Z","end":"2026-04-08T05:05:13.920879Z","steps":["trace[1853354724] 'process raft request' (duration: 392.632413ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:05:13.921065Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:05:13.528116Z","time spent":"392.892051ms","remote":"127.0.0.1:42234","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T05:05:25.998054Z","caller":"traceutil/trace.go:171","msg":"trace[2093539887] linearizableReadLoop","detail":"{readStateIndex:4789; appliedIndex:4788; }","duration":"361.308872ms","start":"2026-04-08T05:05:25.636722Z","end":"2026-04-08T05:05:25.998031Z","steps":["trace[2093539887] 'read index received' (duration: 360.977334ms)","trace[2093539887] 'applied index is now lower than readState.Index' (duration: 330.498µs)"],"step_count":2} {"level":"info","ts":"2026-04-08T05:05:25.998174Z","caller":"traceutil/trace.go:171","msg":"trace[1555935038] transaction","detail":"{read_only:false; response_revision:4611; number_of_response:1; }","duration":"375.058288ms","start":"2026-04-08T05:05:25.623103Z","end":"2026-04-08T05:05:25.998162Z","steps":["trace[1555935038] 'process raft request' (duration: 374.783231ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:05:25.998275Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:05:25.623081Z","time spent":"375.13025ms","remote":"127.0.0.1:42454","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":15212,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T05:05:25.998415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.631363ms","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-04-08T05:05:25.998453Z","caller":"traceutil/trace.go:171","msg":"trace[1744432449] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:4611; }","duration":"174.712905ms","start":"2026-04-08T05:05:25.823729Z","end":"2026-04-08T05:05:25.998442Z","steps":["trace[1744432449] 'agreement among raft nodes before linearized reading' (duration: 174.652134ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:05:25.998432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"361.677173ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/passwords/\" range_end:\"/registry/secretgen.k14s.io/passwords0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-08T05:05:25.998523Z","caller":"traceutil/trace.go:171","msg":"trace[2128109212] range","detail":"{range_begin:/registry/secretgen.k14s.io/passwords/; range_end:/registry/secretgen.k14s.io/passwords0; response_count:0; response_revision:4611; }","duration":"361.812947ms","start":"2026-04-08T05:05:25.636689Z","end":"2026-04-08T05:05:25.998502Z","steps":["trace[2128109212] 'agreement among raft nodes before linearized reading' (duration: 361.652703ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:05:25.998572Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:05:25.636664Z","time spent":"361.89704ms","remote":"127.0.0.1:52036","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":5,"response size":29,"request content":"key:\"/registry/secretgen.k14s.io/passwords/\" range_end:\"/registry/secretgen.k14s.io/passwords0\" count_only:true "} {"level":"warn","ts":"2026-04-08T05:05:25.99885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.709844ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-6089f996-011c-44e3-a6c0-d2e7c0fe8d0a\" ","response":"range_response_count:1 size:3774"} {"level":"info","ts":"2026-04-08T05:05:25.998919Z","caller":"traceutil/trace.go:171","msg":"trace[433638238] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-6089f996-011c-44e3-a6c0-d2e7c0fe8d0a; range_end:; response_count:1; response_revision:4611; }","duration":"226.859029ms","start":"2026-04-08T05:05:25.772043Z","end":"2026-04-08T05:05:25.998902Z","steps":["trace[433638238] 'agreement among raft nodes before linearized reading' (duration: 226.603372ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:05:25.998954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.865906ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:21 size:489391"} {"level":"info","ts":"2026-04-08T05:05:25.999094Z","caller":"traceutil/trace.go:171","msg":"trace[1289572585] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:21; response_revision:4611; }","duration":"342.044582ms","start":"2026-04-08T05:05:25.657028Z","end":"2026-04-08T05:05:25.999073Z","steps":["trace[1289572585] 'agreement among raft nodes before linearized reading' (duration: 341.349713ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:05:25.999172Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:05:25.657015Z","time spent":"342.143995ms","remote":"127.0.0.1:42056","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":21,"response size":489413,"request content":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" "} {"level":"info","ts":"2026-04-08T05:05:26.144481Z","caller":"traceutil/trace.go:171","msg":"trace[1174237809] transaction","detail":"{read_only:false; response_revision:4613; number_of_response:1; }","duration":"101.810225ms","start":"2026-04-08T05:05:26.042647Z","end":"2026-04-08T05:05:26.144458Z","steps":["trace[1174237809] 'process raft request' (duration: 101.408834ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:05:28.150368Z","caller":"traceutil/trace.go:171","msg":"trace[1599452995] transaction","detail":"{read_only:false; response_revision:4634; number_of_response:1; }","duration":"113.52966ms","start":"2026-04-08T05:05:28.0368Z","end":"2026-04-08T05:05:28.15033Z","steps":["trace[1599452995] 'process raft request' (duration: 113.374926ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:05:28.551987Z","caller":"traceutil/trace.go:171","msg":"trace[1757977330] transaction","detail":"{read_only:false; response_revision:4635; number_of_response:1; }","duration":"395.350411ms","start":"2026-04-08T05:05:28.156599Z","end":"2026-04-08T05:05:28.55195Z","steps":["trace[1757977330] 'process raft request' (duration: 368.320096ms)","trace[1757977330] 'compare' (duration: 26.824129ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T05:05:28.552025Z","caller":"traceutil/trace.go:171","msg":"trace[619213350] linearizableReadLoop","detail":"{readStateIndex:4813; appliedIndex:4812; }","duration":"351.232134ms","start":"2026-04-08T05:05:28.200771Z","end":"2026-04-08T05:05:28.552003Z","steps":["trace[619213350] 'read index received' (duration: 324.166099ms)","trace[619213350] 'applied index is now lower than readState.Index' (duration: 27.064645ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T05:05:28.552151Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:05:28.156588Z","time spent":"395.475585ms","remote":"127.0.0.1:42234","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T05:05:28.552306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"351.529023ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-706c663d-495b-4577-9384-0d10e6cf0451\" ","response":"range_response_count:1 size:4050"} {"level":"info","ts":"2026-04-08T05:05:28.552351Z","caller":"traceutil/trace.go:171","msg":"trace[760172897] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-706c663d-495b-4577-9384-0d10e6cf0451; range_end:; response_count:1; response_revision:4636; }","duration":"351.604114ms","start":"2026-04-08T05:05:28.200734Z","end":"2026-04-08T05:05:28.552339Z","steps":["trace[760172897] 'agreement among raft nodes before linearized reading' (duration: 351.372897ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:05:28.552412Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:05:28.200719Z","time spent":"351.682747ms","remote":"127.0.0.1:42150","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":4072,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-706c663d-495b-4577-9384-0d10e6cf0451\" "} {"level":"info","ts":"2026-04-08T05:05:28.552545Z","caller":"traceutil/trace.go:171","msg":"trace[1491497114] transaction","detail":"{read_only:false; response_revision:4636; number_of_response:1; }","duration":"231.345553ms","start":"2026-04-08T05:05:28.320627Z","end":"2026-04-08T05:05:28.551973Z","steps":["trace[1491497114] 'process raft request' (duration: 231.23647ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:05:28.552713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.721323ms","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-04-08T05:05:28.552774Z","caller":"traceutil/trace.go:171","msg":"trace[1603754834] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4636; }","duration":"278.812856ms","start":"2026-04-08T05:05:28.273947Z","end":"2026-04-08T05:05:28.552759Z","steps":["trace[1603754834] 'agreement among raft nodes before linearized reading' (duration: 278.664302ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:05:28.552816Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.126529ms","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-04-08T05:05:28.552857Z","caller":"traceutil/trace.go:171","msg":"trace[504308962] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4636; }","duration":"206.456559ms","start":"2026-04-08T05:05:28.34639Z","end":"2026-04-08T05:05:28.552846Z","steps":["trace[504308962] 'agreement among raft nodes before linearized reading' (duration: 206.338866ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:05:28.552966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.97368ms","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-04-08T05:05:28.553019Z","caller":"traceutil/trace.go:171","msg":"trace[949212349] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4636; }","duration":"279.056032ms","start":"2026-04-08T05:05:28.27395Z","end":"2026-04-08T05:05:28.553006Z","steps":["trace[949212349] 'agreement among raft nodes before linearized reading' (duration: 278.928908ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:05:28.690516Z","caller":"traceutil/trace.go:171","msg":"trace[2087493713] transaction","detail":"{read_only:false; response_revision:4639; number_of_response:1; }","duration":"133.259228ms","start":"2026-04-08T05:05:28.557229Z","end":"2026-04-08T05:05:28.690488Z","steps":["trace[2087493713] 'process raft request' (duration: 133.182856ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:05:28.690725Z","caller":"traceutil/trace.go:171","msg":"trace[1636604155] transaction","detail":"{read_only:false; response_revision:4638; number_of_response:1; }","duration":"134.160584ms","start":"2026-04-08T05:05:28.556551Z","end":"2026-04-08T05:05:28.690711Z","steps":["trace[1636604155] 'process raft request' (duration: 115.190018ms)","trace[1636604155] 'compare' (duration: 18.541605ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T05:05:31.133897Z","caller":"traceutil/trace.go:171","msg":"trace[1161509832] transaction","detail":"{read_only:false; response_revision:4693; number_of_response:1; }","duration":"102.570952ms","start":"2026-04-08T05:05:31.031305Z","end":"2026-04-08T05:05:31.133876Z","steps":["trace[1161509832] 'process raft request' (duration: 102.443669ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:05:31.470262Z","caller":"traceutil/trace.go:171","msg":"trace[290881196] transaction","detail":"{read_only:false; response_revision:4700; number_of_response:1; }","duration":"310.515735ms","start":"2026-04-08T05:05:31.159728Z","end":"2026-04-08T05:05:31.470244Z","steps":["trace[290881196] 'process raft request' (duration: 310.394252ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:05:31.470395Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:05:31.159709Z","time spent":"310.612199ms","remote":"127.0.0.1:42130","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1920,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T05:05:31.476042Z","caller":"traceutil/trace.go:171","msg":"trace[1719404322] transaction","detail":"{read_only:false; response_revision:4701; number_of_response:1; }","duration":"316.156207ms","start":"2026-04-08T05:05:31.159872Z","end":"2026-04-08T05:05:31.476029Z","steps":["trace[1719404322] 'process raft request' (duration: 315.996892ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:05:31.476119Z","caller":"traceutil/trace.go:171","msg":"trace[1699993955] transaction","detail":"{read_only:false; response_revision:4702; number_of_response:1; }","duration":"314.16848ms","start":"2026-04-08T05:05:31.161934Z","end":"2026-04-08T05:05:31.476103Z","steps":["trace[1699993955] 'process raft request' (duration: 314.024746ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:05:31.476136Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:05:31.159853Z","time spent":"316.225119ms","remote":"127.0.0.1:42234","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":539,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T05:05:31.476216Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:05:31.161925Z","time spent":"314.242073ms","remote":"127.0.0.1:42234","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T05:05:31.476489Z","caller":"traceutil/trace.go:171","msg":"trace[151396809] transaction","detail":"{read_only:false; response_revision:4703; number_of_response:1; }","duration":"314.063706ms","start":"2026-04-08T05:05:31.162419Z","end":"2026-04-08T05:05:31.476483Z","steps":["trace[151396809] 'process raft request' (duration: 313.786269ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:05:31.476525Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:05:31.162413Z","time spent":"314.094977ms","remote":"127.0.0.1:42150","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9732,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T05:05:31.476559Z","caller":"traceutil/trace.go:171","msg":"trace[69418438] transaction","detail":"{read_only:false; response_revision:4704; number_of_response:1; }","duration":"306.963944ms","start":"2026-04-08T05:05:31.169586Z","end":"2026-04-08T05:05:31.47655Z","steps":["trace[69418438] 'process raft request' (duration: 306.662376ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:05:31.476608Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:05:31.169566Z","time spent":"307.017707ms","remote":"127.0.0.1:42150","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":14409,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T05:05:35.608297Z","caller":"traceutil/trace.go:171","msg":"trace[1163818331] transaction","detail":"{read_only:false; response_revision:4792; number_of_response:1; }","duration":"116.916312ms","start":"2026-04-08T05:05:35.49136Z","end":"2026-04-08T05:05:35.608276Z","steps":["trace[1163818331] 'process raft request' (duration: 78.6143ms)","trace[1163818331] 'compare' (duration: 37.89551ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T05:05:35.608334Z","caller":"traceutil/trace.go:171","msg":"trace[2007303329] transaction","detail":"{read_only:false; response_revision:4793; number_of_response:1; }","duration":"114.873873ms","start":"2026-04-08T05:05:35.493438Z","end":"2026-04-08T05:05:35.608311Z","steps":["trace[2007303329] 'process raft request' (duration: 114.725419ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:05:36.942991Z","caller":"traceutil/trace.go:171","msg":"trace[1563605446] linearizableReadLoop","detail":"{readStateIndex:4992; appliedIndex:4991; }","duration":"324.530703ms","start":"2026-04-08T05:05:36.618414Z","end":"2026-04-08T05:05:36.942944Z","steps":["trace[1563605446] 'read index received' (duration: 324.259314ms)","trace[1563605446] 'applied index is now lower than readState.Index' (duration: 269.759µs)"],"step_count":2} {"level":"info","ts":"2026-04-08T05:05:36.943027Z","caller":"traceutil/trace.go:171","msg":"trace[791623421] transaction","detail":"{read_only:false; response_revision:4809; number_of_response:1; }","duration":"346.743043ms","start":"2026-04-08T05:05:36.596244Z","end":"2026-04-08T05:05:36.942988Z","steps":["trace[791623421] 'process raft request' (duration: 346.451754ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:05:36.943194Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:05:36.596206Z","time spent":"346.908477ms","remote":"127.0.0.1:42234","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T05:05:36.943241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.81201ms","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-04-08T05:05:36.943276Z","caller":"traceutil/trace.go:171","msg":"trace[1093707171] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4809; }","duration":"324.900413ms","start":"2026-04-08T05:05:36.618364Z","end":"2026-04-08T05:05:36.943265Z","steps":["trace[1093707171] 'agreement among raft nodes before linearized reading' (duration: 324.741298ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:05:36.943312Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:05:36.618346Z","time spent":"324.957785ms","remote":"127.0.0.1:42234","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-04-08T05:05:37.541473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.094442ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-08T05:05:37.541667Z","caller":"traceutil/trace.go:171","msg":"trace[1112074134] transaction","detail":"{read_only:false; response_revision:4811; number_of_response:1; }","duration":"592.599193ms","start":"2026-04-08T05:05:36.949054Z","end":"2026-04-08T05:05:37.541653Z","steps":["trace[1112074134] 'process raft request' (duration: 592.526351ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:05:37.541716Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:05:36.949035Z","time spent":"592.659224ms","remote":"127.0.0.1:42234","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T05:05:37.541931Z","caller":"traceutil/trace.go:171","msg":"trace[836124080] linearizableReadLoop","detail":"{readStateIndex:4993; appliedIndex:4992; }","duration":"598.826912ms","start":"2026-04-08T05:05:36.943078Z","end":"2026-04-08T05:05:37.541905Z","steps":["trace[836124080] 'read index received' (duration: 419.245496ms)","trace[836124080] 'applied index is now lower than readState.Index' (duration: 179.578976ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T05:05:37.542053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"813.403556ms","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-04-08T05:05:37.542076Z","caller":"traceutil/trace.go:171","msg":"trace[1349333918] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4811; }","duration":"813.457266ms","start":"2026-04-08T05:05:36.728612Z","end":"2026-04-08T05:05:37.542069Z","steps":["trace[1349333918] 'agreement among raft nodes before linearized reading' (duration: 813.375324ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:05:37.542095Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:05:36.728593Z","time spent":"813.497578ms","remote":"127.0.0.1:42234","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-04-08T05:05:37.542163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"813.720614ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-08T05:05:37.542183Z","caller":"traceutil/trace.go:171","msg":"trace[831314244] transaction","detail":"{read_only:false; response_revision:4810; number_of_response:1; }","duration":"907.048543ms","start":"2026-04-08T05:05:36.635127Z","end":"2026-04-08T05:05:37.542176Z","steps":["trace[831314244] 'process raft request' (duration: 727.180859ms)","trace[831314244] 'compare' (duration: 178.796124ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T05:05:37.542195Z","caller":"traceutil/trace.go:171","msg":"trace[830572091] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4811; }","duration":"813.842907ms","start":"2026-04-08T05:05:36.728342Z","end":"2026-04-08T05:05:37.542185Z","steps":["trace[830572091] 'agreement among raft nodes before linearized reading' (duration: 813.686373ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:05:37.542221Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:05:36.635084Z","time spent":"907.114395ms","remote":"127.0.0.1:42234","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T05:05:37.542233Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:05:36.728325Z","time spent":"813.90075ms","remote":"127.0.0.1:42234","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-08T05:05:37.542454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"855.90528ms","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-04-08T05:05:37.542546Z","caller":"traceutil/trace.go:171","msg":"trace[238148655] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:4811; }","duration":"856.057425ms","start":"2026-04-08T05:05:36.686465Z","end":"2026-04-08T05:05:37.542523Z","steps":["trace[238148655] 'agreement among raft nodes before linearized reading' (duration: 855.88982ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:05:37.542603Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:05:36.686437Z","time spent":"856.148697ms","remote":"127.0.0.1:44116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":29,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "} {"level":"warn","ts":"2026-04-08T05:05:37.543554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"525.383874ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T05:05:37.543603Z","caller":"traceutil/trace.go:171","msg":"trace[977345210] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4812; }","duration":"525.474326ms","start":"2026-04-08T05:05:37.018114Z","end":"2026-04-08T05:05:37.543588Z","steps":["trace[977345210] 'agreement among raft nodes before linearized reading' (duration: 525.381193ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:05:37.543635Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:05:37.018094Z","time spent":"525.534089ms","remote":"127.0.0.1:41978","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-04-08T05:05:37.543837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.713313ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-0d9f300d-70ec-45e1-998d-ef520e40ccdc\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-04-08T05:05:37.543885Z","caller":"traceutil/trace.go:171","msg":"trace[1000872535] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-0d9f300d-70ec-45e1-998d-ef520e40ccdc; range_end:; response_count:1; response_revision:4812; }","duration":"310.801457ms","start":"2026-04-08T05:05:37.233073Z","end":"2026-04-08T05:05:37.543874Z","steps":["trace[1000872535] 'agreement among raft nodes before linearized reading' (duration: 310.669703ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:05:37.543905Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:05:37.233052Z","time spent":"310.848027ms","remote":"127.0.0.1:42150","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3668,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-0d9f300d-70ec-45e1-998d-ef520e40ccdc\" "} {"level":"warn","ts":"2026-04-08T05:05:37.543972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.853947ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-grafana-84b4fb7bf8-xnvkt.18a4494a37539754\" ","response":"range_response_count:1 size:896"} {"level":"info","ts":"2026-04-08T05:05:37.544031Z","caller":"traceutil/trace.go:171","msg":"trace[414062924] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-grafana-84b4fb7bf8-xnvkt.18a4494a37539754; range_end:; response_count:1; response_revision:4812; }","duration":"338.927479ms","start":"2026-04-08T05:05:37.20509Z","end":"2026-04-08T05:05:37.544017Z","steps":["trace[414062924] 'agreement among raft nodes before linearized reading' (duration: 338.766504ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:05:37.544062Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:05:37.205082Z","time spent":"338.972ms","remote":"127.0.0.1:42042","response type":"/etcdserverpb.KV/Range","request count":0,"request size":93,"response count":1,"response size":918,"request content":"key:\"/registry/events/monitoring/kube-prometheus-stack-grafana-84b4fb7bf8-xnvkt.18a4494a37539754\" "} {"level":"warn","ts":"2026-04-08T05:05:37.544153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.280823ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusterbackups/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterbackups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T05:05:37.544178Z","caller":"traceutil/trace.go:171","msg":"trace[220599159] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusterbackups/; range_end:/registry/pxc.percona.com/perconaxtradbclusterbackups0; response_count:0; response_revision:4812; }","duration":"138.347115ms","start":"2026-04-08T05:05:37.405824Z","end":"2026-04-08T05:05:37.544171Z","steps":["trace[220599159] 'agreement among raft nodes before linearized reading' (duration: 138.306224ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:05:37.544296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"487.626403ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-08T05:05:37.544377Z","caller":"traceutil/trace.go:171","msg":"trace[980195390] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:4812; }","duration":"487.714636ms","start":"2026-04-08T05:05:37.05662Z","end":"2026-04-08T05:05:37.544335Z","steps":["trace[980195390] 'agreement among raft nodes before linearized reading' (duration: 487.600912ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:05:37.544421Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:05:37.056591Z","time spent":"487.819329ms","remote":"127.0.0.1:42150","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":33,"response size":29,"request content":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true "} {"level":"warn","ts":"2026-04-08T05:05:37.544428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"370.674776ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3316"} {"level":"info","ts":"2026-04-08T05:05:37.544521Z","caller":"traceutil/trace.go:171","msg":"trace[1318016647] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:4812; }","duration":"370.852331ms","start":"2026-04-08T05:05:37.173646Z","end":"2026-04-08T05:05:37.544498Z","steps":["trace[1318016647] 'agreement among raft nodes before linearized reading' (duration: 370.50704ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:05:37.544309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.513179ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"warn","ts":"2026-04-08T05:05:37.544564Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:05:37.17363Z","time spent":"370.925283ms","remote":"127.0.0.1:35692","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":1,"response size":3338,"request content":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" "} {"level":"info","ts":"2026-04-08T05:05:37.544584Z","caller":"traceutil/trace.go:171","msg":"trace[1423244473] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4812; }","duration":"274.819388ms","start":"2026-04-08T05:05:37.269754Z","end":"2026-04-08T05:05:37.544573Z","steps":["trace[1423244473] 'agreement among raft nodes before linearized reading' (duration: 274.506388ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:05:37.544758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.050272ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-0d9f300d-70ec-45e1-998d-ef520e40ccdc\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-04-08T05:05:37.544789Z","caller":"traceutil/trace.go:171","msg":"trace[318088782] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-0d9f300d-70ec-45e1-998d-ef520e40ccdc; range_end:; response_count:1; response_revision:4812; }","duration":"340.123234ms","start":"2026-04-08T05:05:37.204659Z","end":"2026-04-08T05:05:37.544782Z","steps":["trace[318088782] 'agreement among raft nodes before linearized reading' (duration: 340.054322ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:05:37.544808Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:05:37.204636Z","time spent":"340.167425ms","remote":"127.0.0.1:42150","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3668,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-0d9f300d-70ec-45e1-998d-ef520e40ccdc\" "} {"level":"warn","ts":"2026-04-08T05:05:38.358826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.309131ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T05:05:38.358912Z","caller":"traceutil/trace.go:171","msg":"trace[8028788] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4822; }","duration":"340.450955ms","start":"2026-04-08T05:05:38.018441Z","end":"2026-04-08T05:05:38.358892Z","steps":["trace[8028788] 'range keys from in-memory index tree' (duration: 340.211227ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:05:38.358956Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:05:38.018423Z","time spent":"340.523886ms","remote":"127.0.0.1:41978","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-04-08T05:05:38.359256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.708075ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-grafana-84b4fb7bf8-xnvkt.18a4494a37539754\" ","response":"range_response_count:1 size:896"} {"level":"info","ts":"2026-04-08T05:05:38.359319Z","caller":"traceutil/trace.go:171","msg":"trace[295860982] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-grafana-84b4fb7bf8-xnvkt.18a4494a37539754; range_end:; response_count:1; response_revision:4822; }","duration":"147.81746ms","start":"2026-04-08T05:05:38.211482Z","end":"2026-04-08T05:05:38.359299Z","steps":["trace[295860982] 'range keys from in-memory index tree' (duration: 147.499919ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:05:38.359536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.822269ms","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-04-08T05:05:38.359627Z","caller":"traceutil/trace.go:171","msg":"trace[1697826992] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4822; }","duration":"137.945122ms","start":"2026-04-08T05:05:38.22166Z","end":"2026-04-08T05:05:38.359605Z","steps":["trace[1697826992] 'range keys from in-memory index tree' (duration: 137.617873ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:05:39.237755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.804732ms","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-04-08T05:05:39.237917Z","caller":"traceutil/trace.go:171","msg":"trace[268556036] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4834; }","duration":"281.992288ms","start":"2026-04-08T05:05:38.955895Z","end":"2026-04-08T05:05:39.237887Z","steps":["trace[268556036] 'range keys from in-memory index tree' (duration: 281.662668ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:05:39.237776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.369032ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T05:05:39.238686Z","caller":"traceutil/trace.go:171","msg":"trace[1857661594] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4834; }","duration":"221.293809ms","start":"2026-04-08T05:05:39.017358Z","end":"2026-04-08T05:05:39.238652Z","steps":["trace[1857661594] 'range keys from in-memory index tree' (duration: 220.28303ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:05:39.349739Z","caller":"traceutil/trace.go:171","msg":"trace[1542193184] transaction","detail":"{read_only:false; response_revision:4835; number_of_response:1; }","duration":"107.044875ms","start":"2026-04-08T05:05:39.242667Z","end":"2026-04-08T05:05:39.349711Z","steps":["trace[1542193184] 'process raft request' (duration: 106.819719ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:05:39.35379Z","caller":"traceutil/trace.go:171","msg":"trace[208919342] transaction","detail":"{read_only:false; response_revision:4836; number_of_response:1; }","duration":"108.811606ms","start":"2026-04-08T05:05:39.244952Z","end":"2026-04-08T05:05:39.353763Z","steps":["trace[208919342] 'process raft request' (duration: 108.535878ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:05:39.617179Z","caller":"traceutil/trace.go:171","msg":"trace[625369145] transaction","detail":"{read_only:false; response_revision:4842; number_of_response:1; }","duration":"232.69361ms","start":"2026-04-08T05:05:39.384471Z","end":"2026-04-08T05:05:39.617165Z","steps":["trace[625369145] 'process raft request' (duration: 232.635768ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:05:39.617179Z","caller":"traceutil/trace.go:171","msg":"trace[1092097851] transaction","detail":"{read_only:false; response_revision:4841; number_of_response:1; }","duration":"233.799012ms","start":"2026-04-08T05:05:39.383364Z","end":"2026-04-08T05:05:39.617163Z","steps":["trace[1092097851] 'process raft request' (duration: 233.696579ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:05:39.617174Z","caller":"traceutil/trace.go:171","msg":"trace[1440824254] transaction","detail":"{read_only:false; response_revision:4840; number_of_response:1; }","duration":"234.40863ms","start":"2026-04-08T05:05:39.382734Z","end":"2026-04-08T05:05:39.617142Z","steps":["trace[1440824254] 'process raft request' (duration: 220.175458ms)","trace[1440824254] 'compare' (duration: 13.946794ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T05:05:39.617536Z","caller":"traceutil/trace.go:171","msg":"trace[2061044084] transaction","detail":"{read_only:false; response_revision:4843; number_of_response:1; }","duration":"232.729162ms","start":"2026-04-08T05:05:39.384782Z","end":"2026-04-08T05:05:39.617511Z","steps":["trace[2061044084] 'process raft request' (duration: 232.35345ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:05:39.670418Z","caller":"traceutil/trace.go:171","msg":"trace[1994499711] linearizableReadLoop","detail":"{readStateIndex:5027; appliedIndex:5022; }","duration":"123.636026ms","start":"2026-04-08T05:05:39.54676Z","end":"2026-04-08T05:05:39.670396Z","steps":["trace[1994499711] 'read index received' (duration: 56.149019ms)","trace[1994499711] 'applied index is now lower than readState.Index' (duration: 67.486017ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T05:05:39.670438Z","caller":"traceutil/trace.go:171","msg":"trace[137149253] transaction","detail":"{read_only:false; response_revision:4844; number_of_response:1; }","duration":"121.121494ms","start":"2026-04-08T05:05:39.549287Z","end":"2026-04-08T05:05:39.670408Z","steps":["trace[137149253] 'process raft request' (duration: 120.933008ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:05:39.670528Z","caller":"traceutil/trace.go:171","msg":"trace[1362422184] transaction","detail":"{read_only:false; response_revision:4845; number_of_response:1; }","duration":"120.197398ms","start":"2026-04-08T05:05:39.55032Z","end":"2026-04-08T05:05:39.670517Z","steps":["trace[1362422184] 'process raft request' (duration: 120.033022ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:05:39.670764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.986297ms","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-04-08T05:05:39.67081Z","caller":"traceutil/trace.go:171","msg":"trace[1480089171] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4845; }","duration":"124.070079ms","start":"2026-04-08T05:05:39.546729Z","end":"2026-04-08T05:05:39.670799Z","steps":["trace[1480089171] 'agreement among raft nodes before linearized reading' (duration: 123.899515ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:05:39.677873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.608286ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-0d9f300d-70ec-45e1-998d-ef520e40ccdc\" ","response":"range_response_count:1 size:3952"} {"level":"info","ts":"2026-04-08T05:05:39.677936Z","caller":"traceutil/trace.go:171","msg":"trace[781531788] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-0d9f300d-70ec-45e1-998d-ef520e40ccdc; range_end:; response_count:1; response_revision:4847; }","duration":"123.678238ms","start":"2026-04-08T05:05:39.554244Z","end":"2026-04-08T05:05:39.677922Z","steps":["trace[781531788] 'agreement among raft nodes before linearized reading' (duration: 123.488873ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:05:39.857805Z","caller":"traceutil/trace.go:171","msg":"trace[2062159245] transaction","detail":"{read_only:false; response_revision:4851; number_of_response:1; }","duration":"112.153654ms","start":"2026-04-08T05:05:39.745632Z","end":"2026-04-08T05:05:39.857786Z","steps":["trace[2062159245] 'process raft request' (duration: 111.998089ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:05:40.169332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.746173ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-08T05:05:40.169411Z","caller":"traceutil/trace.go:171","msg":"trace[1102609180] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:4852; }","duration":"118.887057ms","start":"2026-04-08T05:05:40.050507Z","end":"2026-04-08T05:05:40.169395Z","steps":["trace[1102609180] 'count revisions from in-memory index tree' (duration: 118.647621ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:05:40.169564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.852365ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T05:05:40.169595Z","caller":"traceutil/trace.go:171","msg":"trace[1581949942] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:4852; }","duration":"222.925347ms","start":"2026-04-08T05:05:39.946663Z","end":"2026-04-08T05:05:40.169588Z","steps":["trace[1581949942] 'count revisions from in-memory index tree' (duration: 222.756112ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:05:40.169763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.61147ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T05:05:40.170149Z","caller":"traceutil/trace.go:171","msg":"trace[866745064] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4852; }","duration":"150.047182ms","start":"2026-04-08T05:05:40.020083Z","end":"2026-04-08T05:05:40.17013Z","steps":["trace[866745064] 'range keys from in-memory index tree' (duration: 149.534798ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:05:40.474551Z","caller":"traceutil/trace.go:171","msg":"trace[1582847255] linearizableReadLoop","detail":"{readStateIndex:5038; appliedIndex:5036; }","duration":"202.405875ms","start":"2026-04-08T05:05:40.272122Z","end":"2026-04-08T05:05:40.474528Z","steps":["trace[1582847255] 'read index received' (duration: 33.739881ms)","trace[1582847255] 'applied index is now lower than readState.Index' (duration: 168.664904ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T05:05:40.474597Z","caller":"traceutil/trace.go:171","msg":"trace[65619707] transaction","detail":"{read_only:false; response_revision:4854; number_of_response:1; }","duration":"232.924012ms","start":"2026-04-08T05:05:40.241648Z","end":"2026-04-08T05:05:40.474572Z","steps":["trace[65619707] 'process raft request' (duration: 232.733637ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:05:40.474808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.665262ms","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-04-08T05:05:40.474873Z","caller":"traceutil/trace.go:171","msg":"trace[159074435] 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:4854; }","duration":"202.774435ms","start":"2026-04-08T05:05:40.272081Z","end":"2026-04-08T05:05:40.474855Z","steps":["trace[159074435] 'agreement among raft nodes before linearized reading' (duration: 202.57285ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:05:40.678715Z","caller":"traceutil/trace.go:171","msg":"trace[1218036949] transaction","detail":"{read_only:false; number_of_response:1; response_revision:4857; }","duration":"106.092095ms","start":"2026-04-08T05:05:40.572595Z","end":"2026-04-08T05:05:40.678687Z","steps":["trace[1218036949] 'process raft request' (duration: 97.255768ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:05:40.67879Z","caller":"traceutil/trace.go:171","msg":"trace[899374250] transaction","detail":"{read_only:false; response_revision:4861; number_of_response:1; }","duration":"100.016238ms","start":"2026-04-08T05:05:40.578753Z","end":"2026-04-08T05:05:40.678769Z","steps":["trace[899374250] 'process raft request' (duration: 99.986637ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:05:40.678801Z","caller":"traceutil/trace.go:171","msg":"trace[1704861545] transaction","detail":"{read_only:false; response_revision:4859; number_of_response:1; }","duration":"101.650686ms","start":"2026-04-08T05:05:40.577119Z","end":"2026-04-08T05:05:40.678769Z","steps":["trace[1704861545] 'process raft request' (duration: 101.566154ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:05:40.678855Z","caller":"traceutil/trace.go:171","msg":"trace[624475858] transaction","detail":"{read_only:false; response_revision:4858; number_of_response:1; }","duration":"101.78956ms","start":"2026-04-08T05:05:40.576976Z","end":"2026-04-08T05:05:40.678765Z","steps":["trace[624475858] 'process raft request' (duration: 101.625935ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:05:40.67914Z","caller":"traceutil/trace.go:171","msg":"trace[1332772778] transaction","detail":"{read_only:false; response_revision:4860; number_of_response:1; }","duration":"101.230842ms","start":"2026-04-08T05:05:40.577898Z","end":"2026-04-08T05:05:40.679129Z","steps":["trace[1332772778] 'process raft request' (duration: 100.811821ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:05:41.704865Z","caller":"traceutil/trace.go:171","msg":"trace[1443248319] linearizableReadLoop","detail":"{readStateIndex:5046; appliedIndex:5045; }","duration":"461.762003ms","start":"2026-04-08T05:05:41.243084Z","end":"2026-04-08T05:05:41.704846Z","steps":["trace[1443248319] 'read index received' (duration: 461.65973ms)","trace[1443248319] 'applied index is now lower than readState.Index' (duration: 101.213µs)"],"step_count":2} {"level":"info","ts":"2026-04-08T05:05:41.704948Z","caller":"traceutil/trace.go:171","msg":"trace[260606199] transaction","detail":"{read_only:false; response_revision:4862; number_of_response:1; }","duration":"485.787922ms","start":"2026-04-08T05:05:41.21912Z","end":"2026-04-08T05:05:41.704908Z","steps":["trace[260606199] 'process raft request' (duration: 485.548066ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:05:41.705213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"462.109463ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:13292"} {"level":"info","ts":"2026-04-08T05:05:41.705264Z","caller":"traceutil/trace.go:171","msg":"trace[999016213] range","detail":"{range_begin:/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4862; }","duration":"462.191656ms","start":"2026-04-08T05:05:41.243058Z","end":"2026-04-08T05:05:41.705249Z","steps":["trace[999016213] 'agreement among raft nodes before linearized reading' (duration: 461.886866ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:05:41.705275Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:05:41.219094Z","time spent":"486.077213ms","remote":"127.0.0.1:42042","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":997,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T05:05:41.705297Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:05:41.24304Z","time spent":"462.248107ms","remote":"127.0.0.1:42150","response type":"/etcdserverpb.KV/Range","request count":0,"request size":77,"response count":1,"response size":13314,"request content":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" "} {"level":"warn","ts":"2026-04-08T05:05:41.71402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"390.112566ms","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-04-08T05:05:41.714103Z","caller":"traceutil/trace.go:171","msg":"trace[1108027464] 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:4867; }","duration":"390.19829ms","start":"2026-04-08T05:05:41.323882Z","end":"2026-04-08T05:05:41.714081Z","steps":["trace[1108027464] 'agreement among raft nodes before linearized reading' (duration: 390.018094ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:05:41.714233Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:05:41.32387Z","time spent":"390.347003ms","remote":"127.0.0.1:42130","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":"info","ts":"2026-04-08T05:05:41.714377Z","caller":"traceutil/trace.go:171","msg":"trace[817707865] transaction","detail":"{read_only:false; response_revision:4863; number_of_response:1; }","duration":"470.284592ms","start":"2026-04-08T05:05:41.244074Z","end":"2026-04-08T05:05:41.714359Z","steps":["trace[817707865] 'process raft request' (duration: 469.52703ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:05:41.714471Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:05:41.24405Z","time spent":"470.372564ms","remote":"127.0.0.1:42042","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":853,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-08T05:05:41.714967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"361.377429ms","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-04-08T05:05:41.715044Z","caller":"traceutil/trace.go:171","msg":"trace[1388095141] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4867; }","duration":"361.489552ms","start":"2026-04-08T05:05:41.353537Z","end":"2026-04-08T05:05:41.715026Z","steps":["trace[1388095141] 'agreement among raft nodes before linearized reading' (duration: 361.312007ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:05:41.715092Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:05:41.353521Z","time spent":"361.562866ms","remote":"127.0.0.1:42234","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-04-08T05:05:44.631426Z","caller":"traceutil/trace.go:171","msg":"trace[1167068559] transaction","detail":"{read_only:false; response_revision:4912; number_of_response:1; }","duration":"105.045641ms","start":"2026-04-08T05:05:44.526355Z","end":"2026-04-08T05:05:44.6314Z","steps":["trace[1167068559] 'process raft request' (duration: 104.930267ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:05:44.71908Z","caller":"traceutil/trace.go:171","msg":"trace[856278302] transaction","detail":"{read_only:false; response_revision:4913; number_of_response:1; }","duration":"173.815887ms","start":"2026-04-08T05:05:44.545235Z","end":"2026-04-08T05:05:44.719051Z","steps":["trace[856278302] 'process raft request' (duration: 171.363865ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:05:53.409654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"718.555871ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3316"} {"level":"info","ts":"2026-04-08T05:05:53.409751Z","caller":"traceutil/trace.go:171","msg":"trace[145418988] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:5003; }","duration":"718.689505ms","start":"2026-04-08T05:05:52.691039Z","end":"2026-04-08T05:05:53.409728Z","steps":["trace[145418988] 'range keys from in-memory index tree' (duration: 718.396157ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:05:53.409755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.063078905s","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-04-08T05:05:53.4098Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:05:52.691026Z","time spent":"718.762077ms","remote":"127.0.0.1:35692","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":1,"response size":3338,"request content":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" "} {"level":"info","ts":"2026-04-08T05:05:53.409822Z","caller":"traceutil/trace.go:171","msg":"trace[1478570118] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5003; }","duration":"1.063188698s","start":"2026-04-08T05:05:52.346615Z","end":"2026-04-08T05:05:53.409804Z","steps":["trace[1478570118] 'range keys from in-memory index tree' (duration: 1.062928741s)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:05:53.409862Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:05:52.346597Z","time spent":"1.063255171s","remote":"127.0.0.1:42130","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-04-08T05:05:53.410031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.019207269s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T05:05:53.410164Z","caller":"traceutil/trace.go:171","msg":"trace[735520113] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:5003; }","duration":"1.019373744s","start":"2026-04-08T05:05:52.390778Z","end":"2026-04-08T05:05:53.410152Z","steps":["trace[735520113] 'count revisions from in-memory index tree' (duration: 1.019070425s)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:05:53.410217Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:05:52.390761Z","time spent":"1.019428865s","remote":"127.0.0.1:59074","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"info","ts":"2026-04-08T05:05:53.410717Z","caller":"traceutil/trace.go:171","msg":"trace[453517236] linearizableReadLoop","detail":"{readStateIndex:5193; appliedIndex:5192; }","duration":"526.681076ms","start":"2026-04-08T05:05:52.884022Z","end":"2026-04-08T05:05:53.410703Z","steps":["trace[453517236] 'read index received' (duration: 480.120126ms)","trace[453517236] 'applied index is now lower than readState.Index' (duration: 46.56007ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T05:05:53.410732Z","caller":"traceutil/trace.go:171","msg":"trace[1901729184] transaction","detail":"{read_only:false; response_revision:5004; number_of_response:1; }","duration":"560.649587ms","start":"2026-04-08T05:05:52.850059Z","end":"2026-04-08T05:05:53.410708Z","steps":["trace[1901729184] 'process raft request' (duration: 514.069926ms)","trace[1901729184] 'compare' (duration: 45.422416ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T05:05:53.410717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"745.32066ms","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":"warn","ts":"2026-04-08T05:05:53.410832Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:05:52.850035Z","time spent":"560.73647ms","remote":"127.0.0.1:42234","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T05:05:53.410792Z","caller":"traceutil/trace.go:171","msg":"trace[1830652564] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5003; }","duration":"745.439823ms","start":"2026-04-08T05:05:52.665334Z","end":"2026-04-08T05:05:53.410774Z","steps":["trace[1830652564] 'range keys from in-memory index tree' (duration: 745.163185ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:05:53.410853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"526.83242ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-04-08T05:05:53.411042Z","caller":"traceutil/trace.go:171","msg":"trace[1397905501] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5004; }","duration":"527.057657ms","start":"2026-04-08T05:05:52.883968Z","end":"2026-04-08T05:05:53.411026Z","steps":["trace[1397905501] 'agreement among raft nodes before linearized reading' (duration: 526.784509ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:05:53.411188Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:05:52.665315Z","time spent":"745.814974ms","remote":"127.0.0.1:42234","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":"warn","ts":"2026-04-08T05:05:53.411467Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:05:52.883948Z","time spent":"527.435788ms","remote":"127.0.0.1:42150","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12238,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-04-08T05:05:53.458338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"439.889172ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T05:05:53.458411Z","caller":"traceutil/trace.go:171","msg":"trace[1479529319] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5005; }","duration":"440.007584ms","start":"2026-04-08T05:05:53.018387Z","end":"2026-04-08T05:05:53.458395Z","steps":["trace[1479529319] 'agreement among raft nodes before linearized reading' (duration: 439.819539ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:05:53.458456Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:05:53.018367Z","time spent":"440.078797ms","remote":"127.0.0.1:41978","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-04-08T05:05:53.458469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.69299ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" ","response":"range_response_count:1 size:1990"} {"level":"info","ts":"2026-04-08T05:05:53.458565Z","caller":"traceutil/trace.go:171","msg":"trace[1838573934] range","detail":"{range_begin:/registry/services/specs/ingress-nginx/ingress-nginx-controller; range_end:; response_count:1; response_revision:5005; }","duration":"268.846165ms","start":"2026-04-08T05:05:53.1897Z","end":"2026-04-08T05:05:53.458546Z","steps":["trace[1838573934] 'agreement among raft nodes before linearized reading' (duration: 268.541356ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:05:53.458855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"422.019017ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T05:05:53.458933Z","caller":"traceutil/trace.go:171","msg":"trace[1453693114] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:5005; }","duration":"422.11042ms","start":"2026-04-08T05:05:53.036806Z","end":"2026-04-08T05:05:53.458916Z","steps":["trace[1453693114] 'agreement among raft nodes before linearized reading' (duration: 421.959905ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:05:53.459571Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:05:53.036763Z","time spent":"422.782489ms","remote":"127.0.0.1:58994","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true "} {"level":"info","ts":"2026-04-08T05:05:53.657117Z","caller":"traceutil/trace.go:171","msg":"trace[187444784] transaction","detail":"{read_only:false; response_revision:5008; number_of_response:1; }","duration":"179.775567ms","start":"2026-04-08T05:05:53.477316Z","end":"2026-04-08T05:05:53.657092Z","steps":["trace[187444784] 'process raft request' (duration: 98.84497ms)","trace[187444784] 'compare' (duration: 80.73429ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T05:05:53.657851Z","caller":"traceutil/trace.go:171","msg":"trace[68881543] linearizableReadLoop","detail":"{readStateIndex:5198; appliedIndex:5196; }","duration":"159.204313ms","start":"2026-04-08T05:05:53.498612Z","end":"2026-04-08T05:05:53.657817Z","steps":["trace[68881543] 'read index received' (duration: 77.552596ms)","trace[68881543] 'applied index is now lower than readState.Index' (duration: 81.650587ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T05:05:53.657992Z","caller":"traceutil/trace.go:171","msg":"trace[1873391140] transaction","detail":"{read_only:false; response_revision:5009; number_of_response:1; }","duration":"179.21183ms","start":"2026-04-08T05:05:53.478768Z","end":"2026-04-08T05:05:53.65798Z","steps":["trace[1873391140] 'process raft request' (duration: 178.281443ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:05:53.658198Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.573824ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-grafana.18a449460b3c0191\" ","response":"range_response_count:1 size:736"} {"level":"info","ts":"2026-04-08T05:05:53.658232Z","caller":"traceutil/trace.go:171","msg":"trace[1668801355] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-grafana.18a449460b3c0191; range_end:; response_count:1; response_revision:5009; }","duration":"159.642485ms","start":"2026-04-08T05:05:53.49858Z","end":"2026-04-08T05:05:53.658223Z","steps":["trace[1668801355] 'agreement among raft nodes before linearized reading' (duration: 159.513881ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:05:53.658188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.570559ms","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-04-08T05:05:53.658333Z","caller":"traceutil/trace.go:171","msg":"trace[332629019] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:5009; }","duration":"117.780455ms","start":"2026-04-08T05:05:53.540533Z","end":"2026-04-08T05:05:53.658313Z","steps":["trace[332629019] 'agreement among raft nodes before linearized reading' (duration: 117.549929ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:05:53.658433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.033637ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:1451"} {"level":"info","ts":"2026-04-08T05:05:53.658532Z","caller":"traceutil/trace.go:171","msg":"trace[718694725] range","detail":"{range_begin:/registry/services/specs/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:5009; }","duration":"157.158492ms","start":"2026-04-08T05:05:53.501354Z","end":"2026-04-08T05:05:53.658512Z","steps":["trace[718694725] 'agreement among raft nodes before linearized reading' (duration: 156.881643ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:05:53.658732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.778033ms","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-04-08T05:05:53.658814Z","caller":"traceutil/trace.go:171","msg":"trace[626631229] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:5009; }","duration":"134.927308ms","start":"2026-04-08T05:05:53.523869Z","end":"2026-04-08T05:05:53.658796Z","steps":["trace[626631229] 'agreement among raft nodes before linearized reading' (duration: 134.32796ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:05:53.659373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.460639ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/rabbitmq-keystone.18a44949fc5165fd\" ","response":"range_response_count:1 size:746"} {"level":"info","ts":"2026-04-08T05:05:53.659723Z","caller":"traceutil/trace.go:171","msg":"trace[1679016757] range","detail":"{range_begin:/registry/events/openstack/rabbitmq-keystone.18a44949fc5165fd; range_end:; response_count:1; response_revision:5009; }","duration":"160.800249ms","start":"2026-04-08T05:05:53.49886Z","end":"2026-04-08T05:05:53.65966Z","steps":["trace[1679016757] 'agreement among raft nodes before linearized reading' (duration: 159.128859ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:05:54.107536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.214771ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-08T05:05:54.107739Z","caller":"traceutil/trace.go:171","msg":"trace[1568380624] linearizableReadLoop","detail":"{readStateIndex:5203; appliedIndex:5201; }","duration":"355.638992ms","start":"2026-04-08T05:05:53.75208Z","end":"2026-04-08T05:05:54.107719Z","steps":["trace[1568380624] 'read index received' (duration: 15.154563ms)","trace[1568380624] 'applied index is now lower than readState.Index' (duration: 340.483279ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T05:05:54.107782Z","caller":"traceutil/trace.go:171","msg":"trace[948542450] transaction","detail":"{read_only:false; response_revision:5014; number_of_response:1; }","duration":"356.026953ms","start":"2026-04-08T05:05:53.751726Z","end":"2026-04-08T05:05:54.107753Z","steps":["trace[948542450] 'process raft request' (duration: 355.92872ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:05:54.107888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.678281ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5651"} {"level":"warn","ts":"2026-04-08T05:05:54.10791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.677412ms","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":"info","ts":"2026-04-08T05:05:54.10795Z","caller":"traceutil/trace.go:171","msg":"trace[1616622324] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:5014; }","duration":"359.793626ms","start":"2026-04-08T05:05:53.748139Z","end":"2026-04-08T05:05:54.107933Z","steps":["trace[1616622324] 'agreement among raft nodes before linearized reading' (duration: 359.637091ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:05:54.107949Z","caller":"traceutil/trace.go:171","msg":"trace[378829273] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5014; }","duration":"365.740184ms","start":"2026-04-08T05:05:53.742198Z","end":"2026-04-08T05:05:54.107938Z","steps":["trace[378829273] 'agreement among raft nodes before linearized reading' (duration: 365.605449ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:05:54.107978Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:05:53.748106Z","time spent":"359.866628ms","remote":"127.0.0.1:44168","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5673,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-04-08T05:05:54.107988Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:05:53.741689Z","time spent":"366.29134ms","remote":"127.0.0.1:42130","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":"info","ts":"2026-04-08T05:05:54.107991Z","caller":"traceutil/trace.go:171","msg":"trace[785933877] transaction","detail":"{read_only:false; response_revision:5013; number_of_response:1; }","duration":"358.885279ms","start":"2026-04-08T05:05:53.749094Z","end":"2026-04-08T05:05:54.107979Z","steps":["trace[785933877] 'process raft request' (duration: 18.153132ms)","trace[785933877] 'compare' (duration: 339.447389ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T05:05:54.108048Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:05:53.749076Z","time spent":"358.944441ms","remote":"127.0.0.1:42234","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T05:05:54.107932Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:05:53.751718Z","time spent":"356.135096ms","remote":"127.0.0.1:42234","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T05:05:54.182203Z","caller":"traceutil/trace.go:171","msg":"trace[9876624] transaction","detail":"{read_only:false; response_revision:5015; number_of_response:1; }","duration":"427.986006ms","start":"2026-04-08T05:05:53.754189Z","end":"2026-04-08T05:05:54.182175Z","steps":["trace[9876624] 'process raft request' (duration: 427.827031ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:05:54.18237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"408.221815ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"warn","ts":"2026-04-08T05:05:54.182387Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:05:53.75418Z","time spent":"428.095809ms","remote":"127.0.0.1:42042","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":725,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T05:05:54.182427Z","caller":"traceutil/trace.go:171","msg":"trace[1431691731] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5017; }","duration":"408.323308ms","start":"2026-04-08T05:05:53.77409Z","end":"2026-04-08T05:05:54.182414Z","steps":["trace[1431691731] 'agreement among raft nodes before linearized reading' (duration: 408.157043ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:05:54.182459Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:05:53.774071Z","time spent":"408.38072ms","remote":"127.0.0.1:42234","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":"warn","ts":"2026-04-08T05:05:54.182454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.65708ms","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-04-08T05:05:54.182504Z","caller":"traceutil/trace.go:171","msg":"trace[932283976] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5017; }","duration":"405.799813ms","start":"2026-04-08T05:05:53.77669Z","end":"2026-04-08T05:05:54.182489Z","steps":["trace[932283976] 'agreement among raft nodes before linearized reading' (duration: 405.562306ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:05:54.182542Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:05:53.776682Z","time spent":"405.846705ms","remote":"127.0.0.1:42234","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-04-08T05:05:54.182578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"409.566916ms","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-04-08T05:05:54.182649Z","caller":"traceutil/trace.go:171","msg":"trace[1952724474] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5017; }","duration":"409.654088ms","start":"2026-04-08T05:05:53.772977Z","end":"2026-04-08T05:05:54.182631Z","steps":["trace[1952724474] 'agreement among raft nodes before linearized reading' (duration: 409.413941ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:05:54.182692Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:05:53.772948Z","time spent":"409.736061ms","remote":"127.0.0.1:42234","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-08T05:05:54.18274Z","caller":"traceutil/trace.go:171","msg":"trace[750537319] transaction","detail":"{read_only:false; response_revision:5017; number_of_response:1; }","duration":"424.14873ms","start":"2026-04-08T05:05:53.758578Z","end":"2026-04-08T05:05:54.182727Z","steps":["trace[750537319] 'process raft request' (duration: 423.602864ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:05:54.182718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"426.594364ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-alertmanager.18a449460b3392ea\" ","response":"range_response_count:1 size:751"} {"level":"warn","ts":"2026-04-08T05:05:54.182803Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:05:53.758561Z","time spent":"424.208281ms","remote":"127.0.0.1:42234","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T05:05:54.182828Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.318735ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-08T05:05:54.182843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"414.530165ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-08T05:05:54.182855Z","caller":"traceutil/trace.go:171","msg":"trace[1038890101] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5017; }","duration":"164.372486ms","start":"2026-04-08T05:05:54.018474Z","end":"2026-04-08T05:05:54.182846Z","steps":["trace[1038890101] 'agreement among raft nodes before linearized reading' (duration: 164.331144ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:05:54.182876Z","caller":"traceutil/trace.go:171","msg":"trace[627865491] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5017; }","duration":"414.585326ms","start":"2026-04-08T05:05:53.768281Z","end":"2026-04-08T05:05:54.182867Z","steps":["trace[627865491] 'agreement among raft nodes before linearized reading' (duration: 414.493372ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:05:54.182884Z","caller":"traceutil/trace.go:171","msg":"trace[1297871340] transaction","detail":"{read_only:false; response_revision:5016; number_of_response:1; }","duration":"425.10902ms","start":"2026-04-08T05:05:53.757767Z","end":"2026-04-08T05:05:54.182876Z","steps":["trace[1297871340] 'process raft request' (duration: 424.360788ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:05:54.182905Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:05:53.768271Z","time spent":"414.628088ms","remote":"127.0.0.1:42234","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-08T05:05:54.182892Z","caller":"traceutil/trace.go:171","msg":"trace[939749013] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-alertmanager.18a449460b3392ea; range_end:; response_count:1; response_revision:5017; }","duration":"426.862252ms","start":"2026-04-08T05:05:53.755965Z","end":"2026-04-08T05:05:54.182827Z","steps":["trace[939749013] 'agreement among raft nodes before linearized reading' (duration: 426.366757ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:05:54.182927Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:05:53.757749Z","time spent":"425.154252ms","remote":"127.0.0.1:42234","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T05:05:54.182983Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:05:53.755956Z","time spent":"427.014017ms","remote":"127.0.0.1:42042","response type":"/etcdserverpb.KV/Range","request count":0,"request size":81,"response count":1,"response size":773,"request content":"key:\"/registry/events/monitoring/kube-prometheus-stack-alertmanager.18a449460b3392ea\" "} {"level":"warn","ts":"2026-04-08T05:05:54.688794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.632798ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-08T05:05:54.688906Z","caller":"traceutil/trace.go:171","msg":"trace[1499073771] transaction","detail":"{read_only:false; response_revision:5027; number_of_response:1; }","duration":"155.572762ms","start":"2026-04-08T05:05:54.533307Z","end":"2026-04-08T05:05:54.68888Z","steps":["trace[1499073771] 'process raft request' (duration: 35.79031ms)","trace[1499073771] 'compare' (duration: 119.416152ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T05:05:54.719709Z","caller":"traceutil/trace.go:171","msg":"trace[2119004088] linearizableReadLoop","detail":"{readStateIndex:5218; appliedIndex:5217; }","duration":"111.146974ms","start":"2026-04-08T05:05:54.608544Z","end":"2026-04-08T05:05:54.719691Z","steps":["trace[2119004088] 'read index received' (duration: 110.986449ms)","trace[2119004088] 'applied index is now lower than readState.Index' (duration: 159.915µs)"],"step_count":2} {"level":"warn","ts":"2026-04-08T05:05:54.719835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.282028ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T05:05:54.719866Z","caller":"traceutil/trace.go:171","msg":"trace[600535871] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:5028; }","duration":"111.433763ms","start":"2026-04-08T05:05:54.608426Z","end":"2026-04-08T05:05:54.71986Z","steps":["trace[600535871] 'agreement among raft nodes before linearized reading' (duration: 111.34274ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:05:54.720167Z","caller":"traceutil/trace.go:171","msg":"trace[1239617105] transaction","detail":"{read_only:false; response_revision:5028; number_of_response:1; }","duration":"176.5592ms","start":"2026-04-08T05:05:54.54357Z","end":"2026-04-08T05:05:54.720129Z","steps":["trace[1239617105] 'process raft request' (duration: 176.018404ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:07:01.230184Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2918} {"level":"info","ts":"2026-04-08T05:07:01.330503Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2918,"took":"98.936189ms","hash":2642267153,"current-db-size-bytes":53043200,"current-db-size":"53 MB","current-db-size-in-use-bytes":29114368,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-04-08T05:07:01.330564Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2642267153,"revision":2918,"compact-revision":-1} {"level":"info","ts":"2026-04-08T05:07:06.535603Z","caller":"traceutil/trace.go:171","msg":"trace[1003855391] transaction","detail":"{read_only:false; response_revision:5612; number_of_response:1; }","duration":"101.705587ms","start":"2026-04-08T05:07:06.433865Z","end":"2026-04-08T05:07:06.535571Z","steps":["trace[1003855391] 'process raft request' (duration: 69.778383ms)","trace[1003855391] 'compare' (duration: 31.712337ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T05:07:06.535833Z","caller":"traceutil/trace.go:171","msg":"trace[702615461] transaction","detail":"{read_only:false; response_revision:5613; number_of_response:1; }","duration":"101.908823ms","start":"2026-04-08T05:07:06.433908Z","end":"2026-04-08T05:07:06.535816Z","steps":["trace[702615461] 'process raft request' (duration: 101.608693ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:07:06.845811Z","caller":"traceutil/trace.go:171","msg":"trace[565226968] linearizableReadLoop","detail":"{readStateIndex:5823; appliedIndex:5821; }","duration":"107.433195ms","start":"2026-04-08T05:07:06.738352Z","end":"2026-04-08T05:07:06.845785Z","steps":["trace[565226968] 'read index received' (duration: 1.689775ms)","trace[565226968] 'applied index is now lower than readState.Index' (duration: 105.7424ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T05:07:06.845867Z","caller":"traceutil/trace.go:171","msg":"trace[383470463] transaction","detail":"{read_only:false; response_revision:5616; number_of_response:1; }","duration":"136.189555ms","start":"2026-04-08T05:07:06.709647Z","end":"2026-04-08T05:07:06.845836Z","steps":["trace[383470463] 'process raft request' (duration: 98.031546ms)","trace[383470463] 'compare' (duration: 37.988903ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T05:07:06.846081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.294638ms","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-04-08T05:07:06.846127Z","caller":"traceutil/trace.go:171","msg":"trace[665626657] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5616; }","duration":"106.410372ms","start":"2026-04-08T05:07:06.739705Z","end":"2026-04-08T05:07:06.846115Z","steps":["trace[665626657] 'agreement among raft nodes before linearized reading' (duration: 106.240496ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:07:06.846083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.714526ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-08T05:07:06.846659Z","caller":"traceutil/trace.go:171","msg":"trace[1783651246] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5616; }","duration":"108.327855ms","start":"2026-04-08T05:07:06.738312Z","end":"2026-04-08T05:07:06.84664Z","steps":["trace[1783651246] 'agreement among raft nodes before linearized reading' (duration: 107.598961ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:07:16.103324Z","caller":"traceutil/trace.go:171","msg":"trace[1002758153] transaction","detail":"{read_only:false; response_revision:5665; number_of_response:1; }","duration":"105.337408ms","start":"2026-04-08T05:07:15.997965Z","end":"2026-04-08T05:07:16.103302Z","steps":["trace[1002758153] 'process raft request' (duration: 105.222155ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:09:39.078187Z","caller":"traceutil/trace.go:171","msg":"trace[2144249192] transaction","detail":"{read_only:false; response_revision:6639; number_of_response:1; }","duration":"108.907545ms","start":"2026-04-08T05:09:38.969259Z","end":"2026-04-08T05:09:39.078167Z","steps":["trace[2144249192] 'process raft request' (duration: 108.74615ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:09:44.171926Z","caller":"traceutil/trace.go:171","msg":"trace[1309182092] transaction","detail":"{read_only:false; response_revision:6667; number_of_response:1; }","duration":"142.621501ms","start":"2026-04-08T05:09:44.029272Z","end":"2026-04-08T05:09:44.171893Z","steps":["trace[1309182092] 'process raft request' (duration: 142.388582ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:09:50.166846Z","caller":"traceutil/trace.go:171","msg":"trace[935311046] linearizableReadLoop","detail":"{readStateIndex:6983; appliedIndex:6982; }","duration":"104.983985ms","start":"2026-04-08T05:09:50.061824Z","end":"2026-04-08T05:09:50.166808Z","steps":["trace[935311046] 'read index received' (duration: 104.748237ms)","trace[935311046] 'applied index is now lower than readState.Index' (duration: 233.938µs)"],"step_count":2} {"level":"warn","ts":"2026-04-08T05:09:50.16721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.344348ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/horizon-6f9f7586d6-skwln\" ","response":"range_response_count:1 size:9539"} {"level":"info","ts":"2026-04-08T05:09:50.167315Z","caller":"traceutil/trace.go:171","msg":"trace[50380000] range","detail":"{range_begin:/registry/pods/openstack/horizon-6f9f7586d6-skwln; range_end:; response_count:1; response_revision:6736; }","duration":"105.495004ms","start":"2026-04-08T05:09:50.061778Z","end":"2026-04-08T05:09:50.167273Z","steps":["trace[50380000] 'agreement among raft nodes before linearized reading' (duration: 105.171783ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:09:50.167673Z","caller":"traceutil/trace.go:171","msg":"trace[475988533] transaction","detail":"{read_only:false; response_revision:6736; number_of_response:1; }","duration":"106.314123ms","start":"2026-04-08T05:09:50.061328Z","end":"2026-04-08T05:09:50.167642Z","steps":["trace[475988533] 'process raft request' (duration: 105.266484ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:09:50.4012Z","caller":"traceutil/trace.go:171","msg":"trace[45730844] linearizableReadLoop","detail":"{readStateIndex:6987; appliedIndex:6986; }","duration":"111.687766ms","start":"2026-04-08T05:09:50.289309Z","end":"2026-04-08T05:09:50.400997Z","steps":["trace[45730844] 'read index received' (duration: 110.922429ms)","trace[45730844] 'applied index is now lower than readState.Index' (duration: 764.967µs)"],"step_count":2} {"level":"info","ts":"2026-04-08T05:09:50.401239Z","caller":"traceutil/trace.go:171","msg":"trace[298553320] transaction","detail":"{read_only:false; response_revision:6740; number_of_response:1; }","duration":"123.044435ms","start":"2026-04-08T05:09:50.278111Z","end":"2026-04-08T05:09:50.401156Z","steps":["trace[298553320] 'process raft request' (duration: 122.144983ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:09:50.401615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.275668ms","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-04-08T05:09:50.401678Z","caller":"traceutil/trace.go:171","msg":"trace[1179037366] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:6740; }","duration":"112.363311ms","start":"2026-04-08T05:09:50.289297Z","end":"2026-04-08T05:09:50.40166Z","steps":["trace[1179037366] 'agreement among raft nodes before linearized reading' (duration: 111.924125ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:12:01.241764Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5580} {"level":"info","ts":"2026-04-08T05:12:01.452611Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5580,"took":"209.298838ms","hash":4282872268,"current-db-size-bytes":53043200,"current-db-size":"53 MB","current-db-size-in-use-bytes":18370560,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-04-08T05:12:01.452792Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4282872268,"revision":5580,"compact-revision":2918} {"level":"info","ts":"2026-04-08T05:12:08.076458Z","caller":"traceutil/trace.go:171","msg":"trace[1579911845] linearizableReadLoop","detail":"{readStateIndex:7751; appliedIndex:7750; }","duration":"133.374847ms","start":"2026-04-08T05:12:07.943053Z","end":"2026-04-08T05:12:08.076428Z","steps":["trace[1579911845] 'read index received' (duration: 109.731707ms)","trace[1579911845] 'applied index is now lower than readState.Index' (duration: 23.64219ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T05:12:08.076562Z","caller":"traceutil/trace.go:171","msg":"trace[1298910682] transaction","detail":"{read_only:false; response_revision:7476; number_of_response:1; }","duration":"139.196556ms","start":"2026-04-08T05:12:07.937301Z","end":"2026-04-08T05:12:08.076498Z","steps":["trace[1298910682] 'process raft request' (duration: 115.554525ms)","trace[1298910682] 'compare' (duration: 23.439167ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T05:12:08.077026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.950197ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/openstack/\" range_end:\"/registry/secrets/openstack0\" ","response":"range_response_count:25 size:449309"} {"level":"info","ts":"2026-04-08T05:12:08.077212Z","caller":"traceutil/trace.go:171","msg":"trace[993933178] range","detail":"{range_begin:/registry/secrets/openstack/; range_end:/registry/secrets/openstack0; response_count:25; response_revision:7476; }","duration":"134.099489ms","start":"2026-04-08T05:12:07.943021Z","end":"2026-04-08T05:12:08.077121Z","steps":["trace[993933178] 'agreement among raft nodes before linearized reading' (duration: 133.547131ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:12:09.801542Z","caller":"traceutil/trace.go:171","msg":"trace[1989044205] transaction","detail":"{read_only:false; response_revision:7482; number_of_response:1; }","duration":"103.158497ms","start":"2026-04-08T05:12:09.69836Z","end":"2026-04-08T05:12:09.801519Z","steps":["trace[1989044205] 'process raft request' (duration: 103.024204ms)"],"step_count":1}