{"level":"warn","ts":"2026-05-09T16:53:17.91316Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-05-09T16:53:17.913253Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.162: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.162:2380","--initial-cluster=instance=https://199.204.45.162:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.162:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.162:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]}
{"level":"warn","ts":"2026-05-09T16:53:17.913317Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-05-09T16:53:17.913327Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.162:2380"]}
{"level":"info","ts":"2026-05-09T16:53:17.913346Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-05-09T16:53:17.914114Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.162:2379"]}
{"level":"info","ts":"2026-05-09T16:53:17.914206Z","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.162:2380"],"listen-peer-urls":["https://199.204.45.162:2380"],"advertise-client-urls":["https://199.204.45.162:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.162:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.162:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"}
{"level":"info","ts":"2026-05-09T16:53:17.919163Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.711462ms"}
{"level":"info","ts":"2026-05-09T16:53:17.927804Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"2d372260bb4c37a","cluster-id":"52bb6ec15e8722ff"}
{"level":"info","ts":"2026-05-09T16:53:17.927907Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a switched to configuration voters=()"}
{"level":"info","ts":"2026-05-09T16:53:17.927939Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a became follower at term 0"}
{"level":"info","ts":"2026-05-09T16:53:17.927958Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 2d372260bb4c37a [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-05-09T16:53:17.928238Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a became follower at term 1"}
{"level":"info","ts":"2026-05-09T16:53:17.928302Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a switched to configuration voters=(203631915892523898)"}
{"level":"warn","ts":"2026-05-09T16:53:17.942542Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-05-09T16:53:17.945329Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-05-09T16:53:17.947676Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"}
{"level":"info","ts":"2026-05-09T16:53:17.953689Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"2d372260bb4c37a","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-05-09T16:53:17.954828Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"2d372260bb4c37a","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-05-09T16:53:17.955058Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"}
{"level":"info","ts":"2026-05-09T16:53:17.9551Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"}
{"level":"info","ts":"2026-05-09T16:53:17.955112Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"}
{"level":"info","ts":"2026-05-09T16:53:17.955405Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a switched to configuration voters=(203631915892523898)"}
{"level":"info","ts":"2026-05-09T16:53:17.95553Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"52bb6ec15e8722ff","local-member-id":"2d372260bb4c37a","added-peer-id":"2d372260bb4c37a","added-peer-peer-urls":["https://199.204.45.162:2380"]}
{"level":"info","ts":"2026-05-09T16:53:17.963162Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-05-09T16:53:17.963234Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.162:2380"}
{"level":"info","ts":"2026-05-09T16:53:17.963273Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.162:2380"}
{"level":"info","ts":"2026-05-09T16:53:17.963466Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"2d372260bb4c37a","initial-advertise-peer-urls":["https://199.204.45.162:2380"],"listen-peer-urls":["https://199.204.45.162:2380"],"advertise-client-urls":["https://199.204.45.162:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.162:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-05-09T16:53:17.963514Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-05-09T16:53:18.030784Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a is starting a new election at term 1"}
{"level":"info","ts":"2026-05-09T16:53:18.030859Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a became pre-candidate at term 1"}
{"level":"info","ts":"2026-05-09T16:53:18.030887Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a received MsgPreVoteResp from 2d372260bb4c37a at term 1"}
{"level":"info","ts":"2026-05-09T16:53:18.03091Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a became candidate at term 2"}
{"level":"info","ts":"2026-05-09T16:53:18.030923Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a received MsgVoteResp from 2d372260bb4c37a at term 2"}
{"level":"info","ts":"2026-05-09T16:53:18.030942Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a became leader at term 2"}
{"level":"info","ts":"2026-05-09T16:53:18.030963Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 2d372260bb4c37a elected leader 2d372260bb4c37a at term 2"}
{"level":"info","ts":"2026-05-09T16:53:18.031866Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-09T16:53:18.03275Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-05-09T16:53:18.032754Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"2d372260bb4c37a","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.162:2379]}","request-path":"/0/members/2d372260bb4c37a/attributes","cluster-id":"52bb6ec15e8722ff","publish-timeout":"7s"}
{"level":"info","ts":"2026-05-09T16:53:18.033018Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-05-09T16:53:18.033434Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-05-09T16:53:18.033465Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-05-09T16:53:18.033855Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"52bb6ec15e8722ff","local-member-id":"2d372260bb4c37a","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-09T16:53:18.033977Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-09T16:53:18.034018Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-09T16:53:18.036527Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.162:2379"}
{"level":"info","ts":"2026-05-09T16:53:18.037918Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-05-09T16:53:22.31815Z","caller":"traceutil/trace.go:171","msg":"trace[818989697] linearizableReadLoop","detail":"{readStateIndex:242; appliedIndex:241; }","duration":"303.676058ms","start":"2026-05-09T16:53:22.014443Z","end":"2026-05-09T16:53:22.318119Z","steps":["trace[818989697] 'read index received'  (duration: 303.478014ms)","trace[818989697] 'applied index is now lower than readState.Index'  (duration: 196.794µs)"],"step_count":2}
{"level":"info","ts":"2026-05-09T16:53:22.318203Z","caller":"traceutil/trace.go:171","msg":"trace[1036177687] transaction","detail":"{read_only:false; response_revision:237; number_of_response:1; }","duration":"642.395552ms","start":"2026-05-09T16:53:21.675762Z","end":"2026-05-09T16:53:22.318158Z","steps":["trace[1036177687] 'process raft request'  (duration: 642.218038ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:53:22.318439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.34154ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"}
{"level":"warn","ts":"2026-05-09T16:53:22.318482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.016486ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-09T16:53:22.318602Z","caller":"traceutil/trace.go:171","msg":"trace[541686781] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:237; }","duration":"304.19165ms","start":"2026-05-09T16:53:22.014384Z","end":"2026-05-09T16:53:22.318576Z","steps":["trace[541686781] 'agreement among raft nodes before linearized reading'  (duration: 303.894313ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T16:53:22.318571Z","caller":"traceutil/trace.go:171","msg":"trace[382372607] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:237; }","duration":"250.520465ms","start":"2026-05-09T16:53:22.068036Z","end":"2026-05-09T16:53:22.318557Z","steps":["trace[382372607] 'agreement among raft nodes before linearized reading'  (duration: 250.262779ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:53:22.318662Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:53:22.01434Z","time spent":"304.313133ms","remote":"127.0.0.1:43490","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-05-09T16:53:22.318578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.936083ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"}
{"level":"warn","ts":"2026-05-09T16:53:22.31899Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:53:21.675722Z","time spent":"642.580737ms","remote":"127.0.0.1:43830","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":726,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/rolebindings/kube-public/system:controller:bootstrap-signer\" mod_revision:0 > success:<request_put:<key:\"/registry/rolebindings/kube-public/system:controller:bootstrap-signer\" value_size:649 >> failure:<>"}
{"level":"info","ts":"2026-05-09T16:53:22.319466Z","caller":"traceutil/trace.go:171","msg":"trace[702319391] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:237; }","duration":"248.386994ms","start":"2026-05-09T16:53:22.070477Z","end":"2026-05-09T16:53:22.318864Z","steps":["trace[702319391] 'agreement among raft nodes before linearized reading'  (duration: 247.915643ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:53:22.824261Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14085744566051007523,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-05-09T16:53:23.678298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"472.585155ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14085744566051007524 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:46 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-09T16:53:23.67844Z","caller":"traceutil/trace.go:171","msg":"trace[1617195101] transaction","detail":"{read_only:false; response_revision:238; number_of_response:1; }","duration":"1.355428745s","start":"2026-05-09T16:53:22.322992Z","end":"2026-05-09T16:53:23.678421Z","steps":["trace[1617195101] 'process raft request'  (duration: 882.379198ms)","trace[1617195101] 'compare'  (duration: 472.447612ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T16:53:23.678668Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:53:22.322971Z","time spent":"1.35565796s","remote":"127.0.0.1:43736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:46 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-05-09T16:53:23.769503Z","caller":"traceutil/trace.go:171","msg":"trace[2076189009] linearizableReadLoop","detail":"{readStateIndex:245; appliedIndex:242; }","duration":"1.445511716s","start":"2026-05-09T16:53:22.323966Z","end":"2026-05-09T16:53:23.769477Z","steps":["trace[2076189009] 'read index received'  (duration: 881.420446ms)","trace[2076189009] 'applied index is now lower than readState.Index'  (duration: 564.09032ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T16:53:23.769643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.445667849s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:113"}
{"level":"info","ts":"2026-05-09T16:53:23.769612Z","caller":"traceutil/trace.go:171","msg":"trace[2099347076] transaction","detail":"{read_only:false; response_revision:240; number_of_response:1; }","duration":"1.201452744s","start":"2026-05-09T16:53:22.568102Z","end":"2026-05-09T16:53:23.769555Z","steps":["trace[2099347076] 'process raft request'  (duration: 1.201332661s)"],"step_count":1}
{"level":"info","ts":"2026-05-09T16:53:23.769677Z","caller":"traceutil/trace.go:171","msg":"trace[642541551] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:240; }","duration":"1.445748051s","start":"2026-05-09T16:53:22.323919Z","end":"2026-05-09T16:53:23.769667Z","steps":["trace[642541551] 'agreement among raft nodes before linearized reading'  (duration: 1.44567041s)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:53:23.769715Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:53:22.323903Z","time spent":"1.445799722s","remote":"127.0.0.1:43546","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":1,"response size":135,"request content":"key:\"/registry/ranges/serviceips\" "}
{"level":"info","ts":"2026-05-09T16:53:23.769713Z","caller":"traceutil/trace.go:171","msg":"trace[370118228] transaction","detail":"{read_only:false; response_revision:239; number_of_response:1; }","duration":"1.44611995s","start":"2026-05-09T16:53:22.323561Z","end":"2026-05-09T16:53:23.769681Z","steps":["trace[370118228] 'process raft request'  (duration: 1.445756031s)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:53:23.769781Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:53:22.568071Z","time spent":"1.201624648s","remote":"127.0.0.1:43606","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1069,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/configmaps/kube-system/kubeadm-config\" mod_revision:0 > success:<request_put:<key:\"/registry/configmaps/kube-system/kubeadm-config\" value_size:1014 >> failure:<>"}
{"level":"warn","ts":"2026-05-09T16:53:23.769853Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:53:22.323548Z","time spent":"1.446225143s","remote":"127.0.0.1:43736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:49 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-05-09T16:53:23.860271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"964.85899ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-09T16:53:23.86039Z","caller":"traceutil/trace.go:171","msg":"trace[270761072] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:0; response_revision:241; }","duration":"965.029814ms","start":"2026-05-09T16:53:22.895337Z","end":"2026-05-09T16:53:23.860367Z","steps":["trace[270761072] 'agreement among raft nodes before linearized reading'  (duration: 964.8426ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:53:23.860478Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:53:22.895314Z","time spent":"965.149787ms","remote":"127.0.0.1:43736","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":0,"response size":27,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-05-09T16:53:23.860491Z","caller":"traceutil/trace.go:171","msg":"trace[1727435881] transaction","detail":"{read_only:false; response_revision:241; number_of_response:1; }","duration":"233.228044ms","start":"2026-05-09T16:53:23.627222Z","end":"2026-05-09T16:53:23.860451Z","steps":["trace[1727435881] 'process raft request'  (duration: 230.863298ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:53:48.829378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.466949ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-09T16:53:48.829464Z","caller":"traceutil/trace.go:171","msg":"trace[1077463174] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:0; response_revision:511; }","duration":"180.590352ms","start":"2026-05-09T16:53:48.648853Z","end":"2026-05-09T16:53:48.829443Z","steps":["trace[1077463174] 'range keys from in-memory index tree'  (duration: 180.395307ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T16:53:49.427447Z","caller":"traceutil/trace.go:171","msg":"trace[106856580] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"289.610475ms","start":"2026-05-09T16:53:49.137818Z","end":"2026-05-09T16:53:49.427428Z","steps":["trace[106856580] 'process raft request'  (duration: 289.477672ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T16:53:49.439005Z","caller":"traceutil/trace.go:171","msg":"trace[2077689106] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"283.594801ms","start":"2026-05-09T16:53:49.155393Z","end":"2026-05-09T16:53:49.438988Z","steps":["trace[2077689106] 'process raft request'  (duration: 283.475199ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T16:53:49.439028Z","caller":"traceutil/trace.go:171","msg":"trace[44064933] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"274.106586ms","start":"2026-05-09T16:53:49.164903Z","end":"2026-05-09T16:53:49.43901Z","steps":["trace[44064933] 'process raft request'  (duration: 274.024824ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T16:53:49.439108Z","caller":"traceutil/trace.go:171","msg":"trace[1010613866] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"271.889533ms","start":"2026-05-09T16:53:49.16721Z","end":"2026-05-09T16:53:49.4391Z","steps":["trace[1010613866] 'process raft request'  (duration: 271.798661ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T16:53:49.439084Z","caller":"traceutil/trace.go:171","msg":"trace[843474099] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"296.522049ms","start":"2026-05-09T16:53:49.142528Z","end":"2026-05-09T16:53:49.43905Z","steps":["trace[843474099] 'process raft request'  (duration: 296.263473ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T16:53:49.439158Z","caller":"traceutil/trace.go:171","msg":"trace[2073463446] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"268.40479ms","start":"2026-05-09T16:53:49.170748Z","end":"2026-05-09T16:53:49.439153Z","steps":["trace[2073463446] 'process raft request'  (duration: 268.284668ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T16:53:49.439171Z","caller":"traceutil/trace.go:171","msg":"trace[553244542] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"273.464901ms","start":"2026-05-09T16:53:49.165697Z","end":"2026-05-09T16:53:49.439161Z","steps":["trace[553244542] 'process raft request'  (duration: 273.258596ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T16:53:49.439202Z","caller":"traceutil/trace.go:171","msg":"trace[2124599304] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"268.357179ms","start":"2026-05-09T16:53:49.17084Z","end":"2026-05-09T16:53:49.439197Z","steps":["trace[2124599304] 'process raft request'  (duration: 268.219226ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T16:53:49.439251Z","caller":"traceutil/trace.go:171","msg":"trace[1860983395] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"246.022829ms","start":"2026-05-09T16:53:49.193219Z","end":"2026-05-09T16:53:49.439242Z","steps":["trace[1860983395] 'process raft request'  (duration: 245.873215ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T16:53:49.43931Z","caller":"traceutil/trace.go:171","msg":"trace[1928828768] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"220.496552ms","start":"2026-05-09T16:53:49.218807Z","end":"2026-05-09T16:53:49.439304Z","steps":["trace[1928828768] 'process raft request'  (duration: 220.379559ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T16:53:49.439328Z","caller":"traceutil/trace.go:171","msg":"trace[1187970744] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"131.567777ms","start":"2026-05-09T16:53:49.307738Z","end":"2026-05-09T16:53:49.439306Z","steps":["trace[1187970744] 'process raft request'  (duration: 131.496735ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T16:53:49.439376Z","caller":"traceutil/trace.go:171","msg":"trace[1497038882] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"271.994455ms","start":"2026-05-09T16:53:49.167113Z","end":"2026-05-09T16:53:49.439107Z","steps":["trace[1497038882] 'process raft request'  (duration: 271.871572ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T16:53:49.75955Z","caller":"traceutil/trace.go:171","msg":"trace[1873341931] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"265.44196ms","start":"2026-05-09T16:53:49.494077Z","end":"2026-05-09T16:53:49.759519Z","steps":["trace[1873341931] 'process raft request'  (duration: 257.077541ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T16:53:49.760195Z","caller":"traceutil/trace.go:171","msg":"trace[1408894436] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"257.902351ms","start":"2026-05-09T16:53:49.502273Z","end":"2026-05-09T16:53:49.760176Z","steps":["trace[1408894436] 'process raft request'  (duration: 257.545432ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T16:53:49.760291Z","caller":"traceutil/trace.go:171","msg":"trace[1403529594] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"253.562478ms","start":"2026-05-09T16:53:49.506702Z","end":"2026-05-09T16:53:49.760265Z","steps":["trace[1403529594] 'process raft request'  (duration: 253.379773ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T16:53:49.761377Z","caller":"traceutil/trace.go:171","msg":"trace[1338556836] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"249.543042ms","start":"2026-05-09T16:53:49.511794Z","end":"2026-05-09T16:53:49.761337Z","steps":["trace[1338556836] 'process raft request'  (duration: 248.333763ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T16:53:49.766227Z","caller":"traceutil/trace.go:171","msg":"trace[23065811] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"250.932105ms","start":"2026-05-09T16:53:49.51528Z","end":"2026-05-09T16:53:49.766213Z","steps":["trace[23065811] 'process raft request'  (duration: 245.366953ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T16:53:49.766248Z","caller":"traceutil/trace.go:171","msg":"trace[1762187532] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"219.422456ms","start":"2026-05-09T16:53:49.546805Z","end":"2026-05-09T16:53:49.766227Z","steps":["trace[1762187532] 'process raft request'  (duration: 219.231482ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T16:53:50.188121Z","caller":"traceutil/trace.go:171","msg":"trace[169704399] transaction","detail":"{read_only:false; response_revision:565; number_of_response:1; }","duration":"129.809825ms","start":"2026-05-09T16:53:50.058294Z","end":"2026-05-09T16:53:50.188104Z","steps":["trace[169704399] 'process raft request'  (duration: 98.631704ms)","trace[169704399] 'compare'  (duration: 30.775282ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T16:53:51.687513Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.09754657s","expected-duration":"1s"}
{"level":"info","ts":"2026-05-09T16:53:51.688738Z","caller":"traceutil/trace.go:171","msg":"trace[1840602223] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"1.110240322s","start":"2026-05-09T16:53:50.578473Z","end":"2026-05-09T16:53:51.688713Z","steps":["trace[1840602223] 'process raft request'  (duration: 1.109648278s)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:53:51.689156Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:53:50.578446Z","time spent":"1.110365665s","remote":"127.0.0.1:43544","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":570081,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/envoyproxies.gateway.envoyproxy.io\" mod_revision:578 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/envoyproxies.gateway.envoyproxy.io\" value_size:569980 >> failure:<request_range:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/envoyproxies.gateway.envoyproxy.io\" > >"}
{"level":"info","ts":"2026-05-09T16:53:51.699908Z","caller":"traceutil/trace.go:171","msg":"trace[1448964961] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"1.023892349s","start":"2026-05-09T16:53:50.675994Z","end":"2026-05-09T16:53:51.699886Z","steps":["trace[1448964961] 'process raft request'  (duration: 1.023851158s)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:53:51.700046Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:53:50.675971Z","time spent":"1.024002512s","remote":"127.0.0.1:43736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:458 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"info","ts":"2026-05-09T16:53:51.700284Z","caller":"traceutil/trace.go:171","msg":"trace[1865455252] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"1.082476341s","start":"2026-05-09T16:53:50.617798Z","end":"2026-05-09T16:53:51.700274Z","steps":["trace[1865455252] 'process raft request'  (duration: 1.081972529s)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:53:51.700329Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:53:50.617772Z","time spent":"1.082533443s","remote":"127.0.0.1:43544","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":207462,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/securitypolicies.gateway.envoyproxy.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/securitypolicies.gateway.envoyproxy.io\" value_size:207357 >> failure:<>"}
{"level":"info","ts":"2026-05-09T16:53:51.70048Z","caller":"traceutil/trace.go:171","msg":"trace[1166730652] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"1.108085231s","start":"2026-05-09T16:53:50.592358Z","end":"2026-05-09T16:53:51.700443Z","steps":["trace[1166730652] 'process raft request'  (duration: 1.10723788s)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:53:51.700647Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:53:50.592341Z","time spent":"1.108223523s","remote":"127.0.0.1:43736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:511 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-05-09T16:53:56.215764Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14085744566051008245,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-05-09T16:53:56.716166Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14085744566051008245,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-05-09T16:53:56.876799Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.187316653s","expected-duration":"1s"}
{"level":"info","ts":"2026-05-09T16:53:56.877224Z","caller":"traceutil/trace.go:171","msg":"trace[200216407] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"1.187861137s","start":"2026-05-09T16:53:55.689328Z","end":"2026-05-09T16:53:56.877189Z","steps":["trace[200216407] 'process raft request'  (duration: 1.187680242s)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:53:56.877407Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:53:55.689303Z","time spent":"1.188002769s","remote":"127.0.0.1:43662","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-5bp9k\" mod_revision:502 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-5bp9k\" value_size:17085 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-5bp9k\" > >"}
{"level":"warn","ts":"2026-05-09T16:53:58.082705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.99989842s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-05-09T16:53:58.082796Z","caller":"traceutil/trace.go:171","msg":"trace[1621240603] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000031502s","start":"2026-05-09T16:53:56.082741Z","end":"2026-05-09T16:53:58.082773Z","steps":["trace[1621240603] 'agreement among raft nodes before linearized reading'  (duration: 1.99991754s)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:53:58.082849Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:53:56.082729Z","time spent":"2.000107405s","remote":"127.0.0.1:43490","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-05-09T16:53:58.243814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.033446826s","expected-duration":"100ms","prefix":"","request":"header:<ID:14085744566051008247 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" mod_revision:611 > success:<request_put:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" value_size:1036149 >> failure:<request_range:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-09T16:53:58.24442Z","caller":"traceutil/trace.go:171","msg":"trace[1291485997] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"1.73320651s","start":"2026-05-09T16:53:56.511184Z","end":"2026-05-09T16:53:58.244391Z","steps":["trace[1291485997] 'process raft request'  (duration: 1.73277479s)"],"step_count":1}
{"level":"info","ts":"2026-05-09T16:53:58.244478Z","caller":"traceutil/trace.go:171","msg":"trace[558103461] linearizableReadLoop","detail":"{readStateIndex:636; appliedIndex:632; }","duration":"2.529026237s","start":"2026-05-09T16:53:55.715427Z","end":"2026-05-09T16:53:58.244453Z","steps":["trace[558103461] 'read index received'  (duration: 1.161664753s)","trace[558103461] 'applied index is now lower than readState.Index'  (duration: 1.367358894s)"],"step_count":2}
{"level":"info","ts":"2026-05-09T16:53:58.244489Z","caller":"traceutil/trace.go:171","msg":"trace[799602163] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"2.550007796s","start":"2026-05-09T16:53:55.694448Z","end":"2026-05-09T16:53:58.244456Z","steps":["trace[799602163] 'process raft request'  (duration: 1.515844283s)","trace[799602163] 'compare'  (duration: 1.033125688s)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T16:53:58.244569Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:53:56.511162Z","time spent":"1.733330523s","remote":"127.0.0.1:43654","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4539,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:415 > success:<request_put:<key:\"/registry/minions/instance\" value_size:4505 >> failure:<request_range:<key:\"/registry/minions/instance\" > >"}
{"level":"warn","ts":"2026-05-09T16:53:58.244736Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:53:55.694432Z","time spent":"2.550131668s","remote":"127.0.0.1:43592","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036233,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" mod_revision:611 > success:<request_put:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" value_size:1036149 >> failure:<request_range:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" > >"}
{"level":"info","ts":"2026-05-09T16:53:58.244307Z","caller":"traceutil/trace.go:171","msg":"trace[1476276922] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"1.765120589s","start":"2026-05-09T16:53:56.479117Z","end":"2026-05-09T16:53:58.244237Z","steps":["trace[1476276922] 'process raft request'  (duration: 1.764778081s)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:53:58.254528Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:53:56.479086Z","time spent":"1.775362092s","remote":"127.0.0.1:43736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:472 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"warn","ts":"2026-05-09T16:53:58.263879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.380252161s","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-05-09T16:53:58.263896Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.231685ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-09T16:53:58.263945Z","caller":"traceutil/trace.go:171","msg":"trace[504838050] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:616; }","duration":"2.380319683s","start":"2026-05-09T16:53:55.883608Z","end":"2026-05-09T16:53:58.263928Z","steps":["trace[504838050] 'agreement among raft nodes before linearized reading'  (duration: 2.379232477s)"],"step_count":1}
{"level":"info","ts":"2026-05-09T16:53:58.263957Z","caller":"traceutil/trace.go:171","msg":"trace[78841600] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:616; }","duration":"180.336167ms","start":"2026-05-09T16:53:58.083606Z","end":"2026-05-09T16:53:58.263942Z","steps":["trace[78841600] 'agreement among raft nodes before linearized reading'  (duration: 179.310023ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:53:58.263979Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:53:55.883542Z","time spent":"2.380431266s","remote":"127.0.0.1:43736","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-05-09T16:53:58.264176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.34440489s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-05-09T16:53:58.264193Z","caller":"traceutil/trace.go:171","msg":"trace[531469864] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:616; }","duration":"2.344457261s","start":"2026-05-09T16:53:55.919731Z","end":"2026-05-09T16:53:58.264188Z","steps":["trace[531469864] 'agreement among raft nodes before linearized reading'  (duration: 2.34442461s)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:53:58.264206Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:53:55.91971Z","time spent":"2.344492291s","remote":"127.0.0.1:43736","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-05-09T16:53:58.264412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.548995752s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-05-09T16:53:58.264431Z","caller":"traceutil/trace.go:171","msg":"trace[1217272124] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:616; }","duration":"2.549053562s","start":"2026-05-09T16:53:55.71537Z","end":"2026-05-09T16:53:58.264424Z","steps":["trace[1217272124] 'agreement among raft nodes before linearized reading'  (duration: 2.52918762s)","trace[1217272124] 'range keys from in-memory index tree'  (duration: 18.368147ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T16:53:58.264434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.19045202s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"warn","ts":"2026-05-09T16:53:58.264445Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:53:55.715341Z","time spent":"2.549100624s","remote":"127.0.0.1:43736","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-05-09T16:53:58.26446Z","caller":"traceutil/trace.go:171","msg":"trace[123004886] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:616; }","duration":"2.190514851s","start":"2026-05-09T16:53:56.073938Z","end":"2026-05-09T16:53:58.264453Z","steps":["trace[123004886] 'agreement among raft nodes before linearized reading'  (duration: 2.190176373s)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:53:58.264479Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:53:56.073919Z","time spent":"2.190556182s","remote":"127.0.0.1:43736","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-05-09T16:54:00.07228Z","caller":"traceutil/trace.go:171","msg":"trace[879781642] transaction","detail":"{read_only:false; response_revision:657; number_of_response:1; }","duration":"234.179527ms","start":"2026-05-09T16:53:59.838083Z","end":"2026-05-09T16:54:00.072263Z","steps":["trace[879781642] 'process raft request'  (duration: 234.077294ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T16:54:00.072329Z","caller":"traceutil/trace.go:171","msg":"trace[1718427022] transaction","detail":"{read_only:false; response_revision:656; number_of_response:1; }","duration":"259.912769ms","start":"2026-05-09T16:53:59.8124Z","end":"2026-05-09T16:54:00.072313Z","steps":["trace[1718427022] 'process raft request'  (duration: 252.601185ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:54:12.886478Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14085744566051008620,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-05-09T16:54:13.386732Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14085744566051008620,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-05-09T16:54:13.420394Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.046809464s","expected-duration":"1s"}
{"level":"info","ts":"2026-05-09T16:54:13.420713Z","caller":"traceutil/trace.go:171","msg":"trace[137364402] linearizableReadLoop","detail":"{readStateIndex:805; appliedIndex:804; }","duration":"1.034891251s","start":"2026-05-09T16:54:12.3858Z","end":"2026-05-09T16:54:13.420691Z","steps":["trace[137364402] 'read index received'  (duration: 1.034699256s)","trace[137364402] 'applied index is now lower than readState.Index'  (duration: 191.185µs)"],"step_count":2}
{"level":"info","ts":"2026-05-09T16:54:13.420789Z","caller":"traceutil/trace.go:171","msg":"trace[1326052976] transaction","detail":"{read_only:false; response_revision:780; number_of_response:1; }","duration":"1.047300485s","start":"2026-05-09T16:54:12.373479Z","end":"2026-05-09T16:54:13.42078Z","steps":["trace[1326052976] 'process raft request'  (duration: 1.04708972s)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:54:13.4209Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:54:12.373455Z","time spent":"1.047356297s","remote":"127.0.0.1:43736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:689 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"warn","ts":"2026-05-09T16:54:13.421036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.023235503s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-05-09T16:54:13.421118Z","caller":"traceutil/trace.go:171","msg":"trace[936390966] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:780; }","duration":"1.023371897s","start":"2026-05-09T16:54:12.397732Z","end":"2026-05-09T16:54:13.421104Z","steps":["trace[936390966] 'agreement among raft nodes before linearized reading'  (duration: 1.02308465s)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:54:13.421162Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:54:12.397716Z","time spent":"1.023439198s","remote":"127.0.0.1:43736","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-05-09T16:54:13.421353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.014843943s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"warn","ts":"2026-05-09T16:54:13.421344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.494656ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-09T16:54:13.421374Z","caller":"traceutil/trace.go:171","msg":"trace[1498154777] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:780; }","duration":"1.014906135s","start":"2026-05-09T16:54:12.406462Z","end":"2026-05-09T16:54:13.421368Z","steps":["trace[1498154777] 'agreement among raft nodes before linearized reading'  (duration: 1.014844323s)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:54:13.4214Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:54:12.406442Z","time spent":"1.014954047s","remote":"127.0.0.1:43736","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-05-09T16:54:13.421411Z","caller":"traceutil/trace.go:171","msg":"trace[2122133160] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:780; }","duration":"338.626589ms","start":"2026-05-09T16:54:13.082766Z","end":"2026-05-09T16:54:13.421392Z","steps":["trace[2122133160] 'agreement among raft nodes before linearized reading'  (duration: 338.525927ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:54:13.421409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.013458991s","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-05-09T16:54:13.421449Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:54:13.082738Z","time spent":"338.704011ms","remote":"127.0.0.1:43506","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-05-09T16:54:13.421479Z","caller":"traceutil/trace.go:171","msg":"trace[1446259353] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:780; }","duration":"1.013561383s","start":"2026-05-09T16:54:12.407899Z","end":"2026-05-09T16:54:13.421461Z","steps":["trace[1446259353] 'agreement among raft nodes before linearized reading'  (duration: 1.013371189s)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:54:13.421485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.013498741s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"warn","ts":"2026-05-09T16:54:13.421523Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:54:12.407888Z","time spent":"1.013626904s","remote":"127.0.0.1:43736","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-05-09T16:54:13.421526Z","caller":"traceutil/trace.go:171","msg":"trace[866430249] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:780; }","duration":"1.013556333s","start":"2026-05-09T16:54:12.407958Z","end":"2026-05-09T16:54:13.421514Z","steps":["trace[866430249] 'agreement among raft nodes before linearized reading'  (duration: 1.01339854s)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:54:13.42156Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:54:12.407947Z","time spent":"1.013607224s","remote":"127.0.0.1:43736","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-05-09T16:54:13.421563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"635.66456ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-9g2t4\" ","response":"range_response_count:1 size:3965"}
{"level":"warn","ts":"2026-05-09T16:54:13.421583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.035791822s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:422"}
{"level":"info","ts":"2026-05-09T16:54:13.421609Z","caller":"traceutil/trace.go:171","msg":"trace[858149052] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:780; }","duration":"1.035849443s","start":"2026-05-09T16:54:12.385752Z","end":"2026-05-09T16:54:13.421602Z","steps":["trace[858149052] 'agreement among raft nodes before linearized reading'  (duration: 1.035803112s)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:54:13.421626Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:54:12.385733Z","time spent":"1.035888314s","remote":"127.0.0.1:43652","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":444,"request content":"key:\"/registry/services/endpoints/default/kubernetes\" "}
{"level":"info","ts":"2026-05-09T16:54:13.421621Z","caller":"traceutil/trace.go:171","msg":"trace[1517153450] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-9g2t4; range_end:; response_count:1; response_revision:780; }","duration":"635.758902ms","start":"2026-05-09T16:54:12.78584Z","end":"2026-05-09T16:54:13.421599Z","steps":["trace[1517153450] 'agreement among raft nodes before linearized reading'  (duration: 635.603069ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:54:13.421678Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:54:12.785821Z","time spent":"635.848185ms","remote":"127.0.0.1:43662","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3987,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-9g2t4\" "}
{"level":"warn","ts":"2026-05-09T16:54:13.422024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"914.948579ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-09T16:54:13.422071Z","caller":"traceutil/trace.go:171","msg":"trace[1904467175] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:780; }","duration":"915.037421ms","start":"2026-05-09T16:54:12.507021Z","end":"2026-05-09T16:54:13.422058Z","steps":["trace[1904467175] 'agreement among raft nodes before linearized reading'  (duration: 914.026867ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:54:13.422101Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:54:12.506994Z","time spent":"915.100863ms","remote":"127.0.0.1:43490","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-05-09T16:54:13.572896Z","caller":"traceutil/trace.go:171","msg":"trace[117866874] linearizableReadLoop","detail":"{readStateIndex:806; appliedIndex:805; }","duration":"146.906422ms","start":"2026-05-09T16:54:13.425966Z","end":"2026-05-09T16:54:13.572872Z","steps":["trace[117866874] 'read index received'  (duration: 144.571987ms)","trace[117866874] 'applied index is now lower than readState.Index'  (duration: 2.333355ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T16:54:13.573049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.038326ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:481"}
{"level":"info","ts":"2026-05-09T16:54:13.573087Z","caller":"traceutil/trace.go:171","msg":"trace[855332271] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:781; }","duration":"147.132937ms","start":"2026-05-09T16:54:13.425945Z","end":"2026-05-09T16:54:13.573078Z","steps":["trace[855332271] 'agreement among raft nodes before linearized reading'  (duration: 147.009674ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T16:54:13.573013Z","caller":"traceutil/trace.go:171","msg":"trace[1623317959] transaction","detail":"{read_only:false; response_revision:781; number_of_response:1; }","duration":"147.24316ms","start":"2026-05-09T16:54:13.425739Z","end":"2026-05-09T16:54:13.572982Z","steps":["trace[1623317959] 'process raft request'  (duration: 144.70731ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T16:54:13.582953Z","caller":"traceutil/trace.go:171","msg":"trace[1845699300] transaction","detail":"{read_only:false; response_revision:785; number_of_response:1; }","duration":"152.306991ms","start":"2026-05-09T16:54:13.43063Z","end":"2026-05-09T16:54:13.582937Z","steps":["trace[1845699300] 'process raft request'  (duration: 152.27238ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T16:54:13.5833Z","caller":"traceutil/trace.go:171","msg":"trace[1030343116] transaction","detail":"{read_only:false; response_revision:782; number_of_response:1; }","duration":"156.119371ms","start":"2026-05-09T16:54:13.427173Z","end":"2026-05-09T16:54:13.583292Z","steps":["trace[1030343116] 'process raft request'  (duration: 155.574918ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T16:54:13.583397Z","caller":"traceutil/trace.go:171","msg":"trace[534711066] transaction","detail":"{read_only:false; response_revision:783; number_of_response:1; }","duration":"156.203283ms","start":"2026-05-09T16:54:13.427188Z","end":"2026-05-09T16:54:13.583391Z","steps":["trace[534711066] 'process raft request'  (duration: 155.668741ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T16:54:13.583574Z","caller":"traceutil/trace.go:171","msg":"trace[1794916195] transaction","detail":"{read_only:false; response_revision:784; number_of_response:1; }","duration":"156.160322ms","start":"2026-05-09T16:54:13.427385Z","end":"2026-05-09T16:54:13.583546Z","steps":["trace[1794916195] 'process raft request'  (duration: 155.496956ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T16:54:26.205252Z","caller":"traceutil/trace.go:171","msg":"trace[1693635316] linearizableReadLoop","detail":"{readStateIndex:937; appliedIndex:936; }","duration":"121.048134ms","start":"2026-05-09T16:54:26.084179Z","end":"2026-05-09T16:54:26.205227Z","steps":["trace[1693635316] 'read index received'  (duration: 120.907641ms)","trace[1693635316] 'applied index is now lower than readState.Index'  (duration: 139.473µs)"],"step_count":2}
{"level":"info","ts":"2026-05-09T16:54:26.205288Z","caller":"traceutil/trace.go:171","msg":"trace[973952478] transaction","detail":"{read_only:false; response_revision:909; number_of_response:1; }","duration":"237.830085ms","start":"2026-05-09T16:54:25.967436Z","end":"2026-05-09T16:54:26.205267Z","steps":["trace[973952478] 'process raft request'  (duration: 237.63714ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:54:26.205408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.187568ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-09T16:54:26.205466Z","caller":"traceutil/trace.go:171","msg":"trace[947709330] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:909; }","duration":"121.318541ms","start":"2026-05-09T16:54:26.084132Z","end":"2026-05-09T16:54:26.205451Z","steps":["trace[947709330] 'agreement among raft nodes before linearized reading'  (duration: 121.195088ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T16:54:42.252477Z","caller":"traceutil/trace.go:171","msg":"trace[715196160] linearizableReadLoop","detail":"{readStateIndex:1002; appliedIndex:1000; }","duration":"346.430708ms","start":"2026-05-09T16:54:41.906023Z","end":"2026-05-09T16:54:42.252453Z","steps":["trace[715196160] 'read index received'  (duration: 296.955589ms)","trace[715196160] 'applied index is now lower than readState.Index'  (duration: 49.473969ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T16:54:42.25252Z","caller":"traceutil/trace.go:171","msg":"trace[1891837520] transaction","detail":"{read_only:false; response_revision:970; number_of_response:1; }","duration":"532.343324ms","start":"2026-05-09T16:54:41.720149Z","end":"2026-05-09T16:54:42.252492Z","steps":["trace[1891837520] 'process raft request'  (duration: 532.234862ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T16:54:42.252647Z","caller":"traceutil/trace.go:171","msg":"trace[925485436] transaction","detail":"{read_only:false; response_revision:969; number_of_response:1; }","duration":"535.895561ms","start":"2026-05-09T16:54:41.716722Z","end":"2026-05-09T16:54:42.252617Z","steps":["trace[925485436] 'process raft request'  (duration: 486.351071ms)","trace[925485436] 'compare'  (duration: 48.912875ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T16:54:42.252676Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:54:41.720124Z","time spent":"532.459408ms","remote":"127.0.0.1:43736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:964 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-05-09T16:54:42.252746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.700635ms","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-05-09T16:54:42.25278Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:54:41.71671Z","time spent":"535.998854ms","remote":"127.0.0.1:43736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:963 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-05-09T16:54:42.252802Z","caller":"traceutil/trace.go:171","msg":"trace[1614662841] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:970; }","duration":"346.789266ms","start":"2026-05-09T16:54:41.905997Z","end":"2026-05-09T16:54:42.252786Z","steps":["trace[1614662841] 'agreement among raft nodes before linearized reading'  (duration: 346.615562ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:54:42.252846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:54:41.905983Z","time spent":"346.851039ms","remote":"127.0.0.1:43736","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-05-09T16:54:42.252933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.595215ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-09T16:54:42.252967Z","caller":"traceutil/trace.go:171","msg":"trace[2014266274] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:970; }","duration":"170.662507ms","start":"2026-05-09T16:54:42.082294Z","end":"2026-05-09T16:54:42.252956Z","steps":["trace[2014266274] 'agreement among raft nodes before linearized reading'  (duration: 170.609025ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:54:42.253011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.757134ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-09T16:54:42.253081Z","caller":"traceutil/trace.go:171","msg":"trace[1986979462] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/; range_end:/registry/validatingwebhookconfigurations0; response_count:0; response_revision:970; }","duration":"124.879957ms","start":"2026-05-09T16:54:42.128186Z","end":"2026-05-09T16:54:42.253066Z","steps":["trace[1986979462] 'agreement among raft nodes before linearized reading'  (duration: 124.737944ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:54:47.842579Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.516588ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14085744566051009069 > lease_revoke:<id:437a9e0da85bf1a5>","response":"size:27"}
{"level":"info","ts":"2026-05-09T16:54:47.842685Z","caller":"traceutil/trace.go:171","msg":"trace[189538003] linearizableReadLoop","detail":"{readStateIndex:1025; appliedIndex:1024; }","duration":"108.707405ms","start":"2026-05-09T16:54:47.73396Z","end":"2026-05-09T16:54:47.842668Z","steps":["trace[189538003] 'read index received'  (duration: 29.521µs)","trace[189538003] 'applied index is now lower than readState.Index'  (duration: 108.676494ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T16:54:47.842925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.952311ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-05-09T16:54:47.842965Z","caller":"traceutil/trace.go:171","msg":"trace[2079729638] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:990; }","duration":"109.030073ms","start":"2026-05-09T16:54:47.733923Z","end":"2026-05-09T16:54:47.842953Z","steps":["trace[2079729638] 'agreement among raft nodes before linearized reading'  (duration: 108.848419ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:54:47.843063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.279981ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-05-09T16:54:47.843163Z","caller":"traceutil/trace.go:171","msg":"trace[1820433061] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:990; }","duration":"100.394503ms","start":"2026-05-09T16:54:47.742732Z","end":"2026-05-09T16:54:47.843127Z","steps":["trace[1820433061] 'agreement among raft nodes before linearized reading'  (duration: 100.156368ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:54:48.781193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"694.546587ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-09T16:54:48.781255Z","caller":"traceutil/trace.go:171","msg":"trace[1573248053] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:992; }","duration":"694.6616ms","start":"2026-05-09T16:54:48.086578Z","end":"2026-05-09T16:54:48.781239Z","steps":["trace[1573248053] 'count revisions from in-memory index tree'  (duration: 694.424054ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:54:48.781283Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:54:48.086549Z","time spent":"694.727411ms","remote":"127.0.0.1:43810","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":0,"response size":27,"request content":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true "}
{"level":"warn","ts":"2026-05-09T16:54:48.781898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.72352ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14085744566051009075 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:987 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-09T16:54:48.781946Z","caller":"traceutil/trace.go:171","msg":"trace[303047177] linearizableReadLoop","detail":"{readStateIndex:1028; appliedIndex:1027; }","duration":"507.488423ms","start":"2026-05-09T16:54:48.274451Z","end":"2026-05-09T16:54:48.781939Z","steps":["trace[303047177] 'read index received'  (duration: 206.66862ms)","trace[303047177] 'applied index is now lower than readState.Index'  (duration: 300.819133ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T16:54:48.782158Z","caller":"traceutil/trace.go:171","msg":"trace[150266256] transaction","detail":"{read_only:false; response_revision:993; number_of_response:1; }","duration":"508.480577ms","start":"2026-05-09T16:54:48.27367Z","end":"2026-05-09T16:54:48.782151Z","steps":["trace[150266256] 'process raft request'  (duration: 207.437629ms)","trace[150266256] 'compare'  (duration: 300.503175ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T16:54:48.782282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"507.831341ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"info","ts":"2026-05-09T16:54:48.7823Z","caller":"traceutil/trace.go:171","msg":"trace[1330113638] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:993; }","duration":"507.886042ms","start":"2026-05-09T16:54:48.274408Z","end":"2026-05-09T16:54:48.782294Z","steps":["trace[1330113638] 'agreement among raft nodes before linearized reading'  (duration: 507.809461ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:54:48.782324Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:54:48.274388Z","time spent":"507.932413ms","remote":"127.0.0.1:43736","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-05-09T16:54:48.782401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"507.892043ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"info","ts":"2026-05-09T16:54:48.782431Z","caller":"traceutil/trace.go:171","msg":"trace[1401488158] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:993; }","duration":"507.943624ms","start":"2026-05-09T16:54:48.27448Z","end":"2026-05-09T16:54:48.782424Z","steps":["trace[1401488158] 'agreement among raft nodes before linearized reading'  (duration: 507.852911ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:54:48.782451Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:54:48.274471Z","time spent":"507.976004ms","remote":"127.0.0.1:43736","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-05-09T16:54:48.782481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.935308ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-05-09T16:54:48.782523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"501.688792ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-05-09T16:54:48.782544Z","caller":"traceutil/trace.go:171","msg":"trace[2003414665] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:993; }","duration":"501.738833ms","start":"2026-05-09T16:54:48.2808Z","end":"2026-05-09T16:54:48.782539Z","steps":["trace[2003414665] 'agreement among raft nodes before linearized reading'  (duration: 501.684262ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T16:54:48.782542Z","caller":"traceutil/trace.go:171","msg":"trace[1637845457] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:993; }","duration":"257.032591ms","start":"2026-05-09T16:54:48.525494Z","end":"2026-05-09T16:54:48.782526Z","steps":["trace[1637845457] 'agreement among raft nodes before linearized reading'  (duration: 256.920588ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:54:48.782562Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:54:48.280785Z","time spent":"501.773764ms","remote":"127.0.0.1:43736","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-05-09T16:54:48.782723Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:54:48.273652Z","time spent":"508.522767ms","remote":"127.0.0.1:43736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:987 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"info","ts":"2026-05-09T16:54:49.21401Z","caller":"traceutil/trace.go:171","msg":"trace[1804155870] linearizableReadLoop","detail":"{readStateIndex:1031; appliedIndex:1029; }","duration":"130.422332ms","start":"2026-05-09T16:54:49.083571Z","end":"2026-05-09T16:54:49.213993Z","steps":["trace[1804155870] 'read index received'  (duration: 129.614102ms)","trace[1804155870] 'applied index is now lower than readState.Index'  (duration: 807.5µs)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T16:54:49.21411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.527164ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-09T16:54:49.214136Z","caller":"traceutil/trace.go:171","msg":"trace[357345115] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:996; }","duration":"130.590216ms","start":"2026-05-09T16:54:49.083538Z","end":"2026-05-09T16:54:49.214128Z","steps":["trace[357345115] 'agreement among raft nodes before linearized reading'  (duration: 130.525134ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T16:54:49.214283Z","caller":"traceutil/trace.go:171","msg":"trace[1025184622] transaction","detail":"{read_only:false; response_revision:996; number_of_response:1; }","duration":"426.765075ms","start":"2026-05-09T16:54:48.787504Z","end":"2026-05-09T16:54:49.214269Z","steps":["trace[1025184622] 'process raft request'  (duration: 426.438927ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T16:54:49.214307Z","caller":"traceutil/trace.go:171","msg":"trace[1858681086] transaction","detail":"{read_only:false; response_revision:995; number_of_response:1; }","duration":"426.842448ms","start":"2026-05-09T16:54:48.787414Z","end":"2026-05-09T16:54:49.214256Z","steps":["trace[1858681086] 'process raft request'  (duration: 425.852974ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:54:49.214399Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:54:48.787497Z","time spent":"426.824048ms","remote":"127.0.0.1:43736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:988 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-05-09T16:54:49.214613Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:54:48.787389Z","time spent":"427.039302ms","remote":"127.0.0.1:43736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:989 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-05-09T16:54:56.134218Z","caller":"traceutil/trace.go:171","msg":"trace[333838266] transaction","detail":"{read_only:false; response_revision:1019; number_of_response:1; }","duration":"192.488806ms","start":"2026-05-09T16:54:55.941701Z","end":"2026-05-09T16:54:56.13419Z","steps":["trace[333838266] 'process raft request'  (duration: 190.885627ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:54:57.111728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.721115ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-05-09T16:54:57.111849Z","caller":"traceutil/trace.go:171","msg":"trace[1458098195] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1020; }","duration":"221.849988ms","start":"2026-05-09T16:54:56.889953Z","end":"2026-05-09T16:54:57.111803Z","steps":["trace[1458098195] 'range keys from in-memory index tree'  (duration: 221.573032ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:54:57.751581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.803877ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14085744566051009152 > lease_revoke:<id:437a9e0da85bf1f4>","response":"size:27"}
{"level":"warn","ts":"2026-05-09T16:55:11.385044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.987601ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-09T16:55:11.385151Z","caller":"traceutil/trace.go:171","msg":"trace[1299349225] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:1066; }","duration":"196.163606ms","start":"2026-05-09T16:55:11.188968Z","end":"2026-05-09T16:55:11.385132Z","steps":["trace[1299349225] 'count revisions from in-memory index tree'  (duration: 195.895459ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T16:55:11.631948Z","caller":"traceutil/trace.go:171","msg":"trace[2098134996] transaction","detail":"{read_only:false; response_revision:1068; number_of_response:1; }","duration":"150.013376ms","start":"2026-05-09T16:55:11.481913Z","end":"2026-05-09T16:55:11.631926Z","steps":["trace[2098134996] 'process raft request'  (duration: 145.562329ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T16:55:11.651583Z","caller":"traceutil/trace.go:171","msg":"trace[235840668] transaction","detail":"{read_only:false; response_revision:1069; number_of_response:1; }","duration":"167.921961ms","start":"2026-05-09T16:55:11.483631Z","end":"2026-05-09T16:55:11.651553Z","steps":["trace[235840668] 'process raft request'  (duration: 167.800438ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T16:55:13.504015Z","caller":"traceutil/trace.go:171","msg":"trace[1416443279] transaction","detail":"{read_only:false; response_revision:1073; number_of_response:1; }","duration":"433.414076ms","start":"2026-05-09T16:55:13.070571Z","end":"2026-05-09T16:55:13.503985Z","steps":["trace[1416443279] 'process raft request'  (duration: 433.196271ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:55:13.504164Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:55:13.070536Z","time spent":"433.54967ms","remote":"127.0.0.1:43736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:1066 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:458 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"warn","ts":"2026-05-09T16:55:13.765028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.820812ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14085744566051009298 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:1067 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-09T16:55:13.765161Z","caller":"traceutil/trace.go:171","msg":"trace[217253884] linearizableReadLoop","detail":"{readStateIndex:1114; appliedIndex:1113; }","duration":"159.65967ms","start":"2026-05-09T16:55:13.605479Z","end":"2026-05-09T16:55:13.765139Z","steps":["trace[217253884] 'read index received'  (duration: 9.654624ms)","trace[217253884] 'applied index is now lower than readState.Index'  (duration: 150.003606ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T16:55:13.765266Z","caller":"traceutil/trace.go:171","msg":"trace[720730752] transaction","detail":"{read_only:false; response_revision:1074; number_of_response:1; }","duration":"256.832826ms","start":"2026-05-09T16:55:13.508417Z","end":"2026-05-09T16:55:13.76525Z","steps":["trace[720730752] 'process raft request'  (duration: 106.696626ms)","trace[720730752] 'compare'  (duration: 149.711859ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T16:55:13.765363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.874736ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-05-09T16:55:13.76539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.10099ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-05-09T16:55:13.765427Z","caller":"traceutil/trace.go:171","msg":"trace[1740565091] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:1074; }","duration":"159.979818ms","start":"2026-05-09T16:55:13.605431Z","end":"2026-05-09T16:55:13.765411Z","steps":["trace[1740565091] 'agreement among raft nodes before linearized reading'  (duration: 159.869795ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T16:55:13.765481Z","caller":"traceutil/trace.go:171","msg":"trace[1394184569] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1074; }","duration":"129.218663ms","start":"2026-05-09T16:55:13.636242Z","end":"2026-05-09T16:55:13.765461Z","steps":["trace[1394184569] 'agreement among raft nodes before linearized reading'  (duration: 129.016968ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:55:13.765978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.258687ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-05-09T16:55:13.766045Z","caller":"traceutil/trace.go:171","msg":"trace[1682217088] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1074; }","duration":"111.34764ms","start":"2026-05-09T16:55:13.654681Z","end":"2026-05-09T16:55:13.766029Z","steps":["trace[1682217088] 'agreement among raft nodes before linearized reading'  (duration: 110.94737ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T16:55:14.329134Z","caller":"traceutil/trace.go:171","msg":"trace[190268473] transaction","detail":"{read_only:false; response_revision:1077; number_of_response:1; }","duration":"200.729136ms","start":"2026-05-09T16:55:14.128381Z","end":"2026-05-09T16:55:14.32911Z","steps":["trace[190268473] 'process raft request'  (duration: 200.606023ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T16:55:16.097419Z","caller":"traceutil/trace.go:171","msg":"trace[730759551] linearizableReadLoop","detail":"{readStateIndex:1122; appliedIndex:1121; }","duration":"263.216111ms","start":"2026-05-09T16:55:15.834176Z","end":"2026-05-09T16:55:16.097392Z","steps":["trace[730759551] 'read index received'  (duration: 220.197478ms)","trace[730759551] 'applied index is now lower than readState.Index'  (duration: 43.017323ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T16:55:16.097486Z","caller":"traceutil/trace.go:171","msg":"trace[563796594] transaction","detail":"{read_only:false; response_revision:1082; number_of_response:1; }","duration":"296.414395ms","start":"2026-05-09T16:55:15.801031Z","end":"2026-05-09T16:55:16.097445Z","steps":["trace[563796594] 'process raft request'  (duration: 253.372312ms)","trace[563796594] 'compare'  (duration: 42.854408ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T16:55:16.097832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.59816ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-05-09T16:55:16.09796Z","caller":"traceutil/trace.go:171","msg":"trace[467228761] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1082; }","duration":"263.779035ms","start":"2026-05-09T16:55:15.83415Z","end":"2026-05-09T16:55:16.097929Z","steps":["trace[467228761] 'agreement among raft nodes before linearized reading'  (duration: 263.332114ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T16:55:23.71138Z","caller":"traceutil/trace.go:171","msg":"trace[554672269] transaction","detail":"{read_only:false; response_revision:1106; number_of_response:1; }","duration":"154.775652ms","start":"2026-05-09T16:55:23.556564Z","end":"2026-05-09T16:55:23.71134Z","steps":["trace[554672269] 'process raft request'  (duration: 154.544646ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T16:55:28.021285Z","caller":"traceutil/trace.go:171","msg":"trace[1579159705] transaction","detail":"{read_only:false; response_revision:1171; number_of_response:1; }","duration":"142.459088ms","start":"2026-05-09T16:55:27.878794Z","end":"2026-05-09T16:55:28.021253Z","steps":["trace[1579159705] 'process raft request'  (duration: 133.752432ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:55:28.325469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.695728ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-09T16:55:28.325554Z","caller":"traceutil/trace.go:171","msg":"trace[1177667458] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1171; }","duration":"240.813301ms","start":"2026-05-09T16:55:28.084721Z","end":"2026-05-09T16:55:28.325534Z","steps":["trace[1177667458] 'range keys from in-memory index tree'  (duration: 240.643667ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:55:28.325704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.030768ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"info","ts":"2026-05-09T16:55:28.325734Z","caller":"traceutil/trace.go:171","msg":"trace[1191741045] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1171; }","duration":"142.09102ms","start":"2026-05-09T16:55:28.183634Z","end":"2026-05-09T16:55:28.325725Z","steps":["trace[1191741045] 'range keys from in-memory index tree'  (duration: 141.916785ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T16:55:28.470989Z","caller":"traceutil/trace.go:171","msg":"trace[1019648812] transaction","detail":"{read_only:false; response_revision:1172; number_of_response:1; }","duration":"141.339422ms","start":"2026-05-09T16:55:28.329623Z","end":"2026-05-09T16:55:28.470963Z","steps":["trace[1019648812] 'process raft request'  (duration: 141.191138ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:55:29.142815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"390.174481ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14085744566051009518 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:1115 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-09T16:55:29.142908Z","caller":"traceutil/trace.go:171","msg":"trace[1327186516] linearizableReadLoop","detail":"{readStateIndex:1218; appliedIndex:1217; }","duration":"633.536203ms","start":"2026-05-09T16:55:28.509356Z","end":"2026-05-09T16:55:29.142893Z","steps":["trace[1327186516] 'read index received'  (duration: 243.136906ms)","trace[1327186516] 'applied index is now lower than readState.Index'  (duration: 390.397797ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T16:55:29.143122Z","caller":"traceutil/trace.go:171","msg":"trace[1220230053] transaction","detail":"{read_only:false; response_revision:1173; number_of_response:1; }","duration":"813.391418ms","start":"2026-05-09T16:55:28.329718Z","end":"2026-05-09T16:55:29.143109Z","steps":["trace[1220230053] 'process raft request'  (duration: 422.834988ms)","trace[1220230053] 'compare'  (duration: 389.877694ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T16:55:29.143179Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:55:28.329696Z","time spent":"813.452929ms","remote":"127.0.0.1:43736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:1115 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-05-09T16:55:29.143409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"634.050885ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-05-09T16:55:29.143438Z","caller":"traceutil/trace.go:171","msg":"trace[1055146375] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1173; }","duration":"634.101366ms","start":"2026-05-09T16:55:28.509327Z","end":"2026-05-09T16:55:29.143428Z","steps":["trace[1055146375] 'agreement among raft nodes before linearized reading'  (duration: 633.990583ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:55:29.143467Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:55:28.509313Z","time spent":"634.148138ms","remote":"127.0.0.1:43736","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-05-09T16:55:29.1436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"601.729069ms","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-05-09T16:55:29.143627Z","caller":"traceutil/trace.go:171","msg":"trace[2049416962] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:1173; }","duration":"601.788819ms","start":"2026-05-09T16:55:28.54183Z","end":"2026-05-09T16:55:29.143619Z","steps":["trace[2049416962] 'agreement among raft nodes before linearized reading'  (duration: 601.746198ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:55:29.143657Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:55:28.541813Z","time spent":"601.836761ms","remote":"127.0.0.1:38546","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/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "}
{"level":"warn","ts":"2026-05-09T16:55:29.143947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"505.886906ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-05-09T16:55:29.143977Z","caller":"traceutil/trace.go:171","msg":"trace[1229485080] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1173; }","duration":"505.956328ms","start":"2026-05-09T16:55:28.638012Z","end":"2026-05-09T16:55:29.143968Z","steps":["trace[1229485080] 'agreement among raft nodes before linearized reading'  (duration: 505.866076ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:55:29.144002Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:55:28.637984Z","time spent":"506.012538ms","remote":"127.0.0.1:43736","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-05-09T16:55:29.276252Z","caller":"traceutil/trace.go:171","msg":"trace[1849950177] transaction","detail":"{read_only:false; response_revision:1175; number_of_response:1; }","duration":"127.31728ms","start":"2026-05-09T16:55:29.148889Z","end":"2026-05-09T16:55:29.276206Z","steps":["trace[1849950177] 'process raft request'  (duration: 121.974243ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:55:30.281977Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14085744566051009523,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-05-09T16:55:30.782172Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14085744566051009523,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-05-09T16:55:31.283234Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14085744566051009523,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-05-09T16:55:31.783591Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14085744566051009523,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-05-09T16:55:32.080354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000422559s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-05-09T16:55:32.080447Z","caller":"traceutil/trace.go:171","msg":"trace[188460014] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000559662s","start":"2026-05-09T16:55:30.079867Z","end":"2026-05-09T16:55:32.080426Z","steps":["trace[188460014] 'agreement among raft nodes before linearized reading'  (duration: 2.000442659s)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:55:32.080497Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:55:30.079855Z","time spent":"2.000633144s","remote":"127.0.0.1:43506","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-05-09T16:55:32.283764Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14085744566051009523,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-05-09T16:55:32.784202Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14085744566051009523,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-05-09T16:55:33.284971Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14085744566051009523,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-05-09T16:55:33.786065Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14085744566051009523,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-05-09T16:55:34.025645Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"4.284679598s","expected-duration":"1s"}
{"level":"info","ts":"2026-05-09T16:55:34.026076Z","caller":"traceutil/trace.go:171","msg":"trace[1468363990] transaction","detail":"{read_only:false; response_revision:1176; number_of_response:1; }","duration":"4.285167089s","start":"2026-05-09T16:55:29.740864Z","end":"2026-05-09T16:55:34.026031Z","steps":["trace[1468363990] 'process raft request'  (duration: 4.285023466s)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:55:34.026317Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:55:29.740844Z","time spent":"4.285335233s","remote":"127.0.0.1:43736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:1170 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"info","ts":"2026-05-09T16:55:34.029052Z","caller":"traceutil/trace.go:171","msg":"trace[1627987401] transaction","detail":"{read_only:false; response_revision:1177; number_of_response:1; }","duration":"3.954749664s","start":"2026-05-09T16:55:30.074256Z","end":"2026-05-09T16:55:34.029006Z","steps":["trace[1627987401] 'process raft request'  (duration: 3.954464807s)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:55:34.029379Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:55:30.074228Z","time spent":"3.954903668s","remote":"127.0.0.1:43736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:1094 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:471 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"warn","ts":"2026-05-09T16:55:34.029787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.248813968s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-05-09T16:55:34.029838Z","caller":"traceutil/trace.go:171","msg":"trace[1813436633] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:1177; }","duration":"4.248962711s","start":"2026-05-09T16:55:29.780861Z","end":"2026-05-09T16:55:34.029824Z","steps":["trace[1813436633] 'agreement among raft nodes before linearized reading'  (duration: 4.248777177s)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:55:34.029995Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:55:29.780728Z","time spent":"4.249251368s","remote":"127.0.0.1:38750","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":4,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true "}
{"level":"info","ts":"2026-05-09T16:55:34.028987Z","caller":"traceutil/trace.go:171","msg":"trace[521144246] linearizableReadLoop","detail":"{readStateIndex:1222; appliedIndex:1220; }","duration":"4.248033258s","start":"2026-05-09T16:55:29.780919Z","end":"2026-05-09T16:55:34.028952Z","steps":["trace[521144246] 'read index received'  (duration: 4.244899994s)","trace[521144246] 'applied index is now lower than readState.Index'  (duration: 3.131794ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T16:55:34.032317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.82404133s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"warn","ts":"2026-05-09T16:55:34.032343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.005561328s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-05-09T16:55:34.032382Z","caller":"traceutil/trace.go:171","msg":"trace[2106005473] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:1177; }","duration":"2.824159472s","start":"2026-05-09T16:55:31.20821Z","end":"2026-05-09T16:55:34.032369Z","steps":["trace[2106005473] 'agreement among raft nodes before linearized reading'  (duration: 2.824001009s)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:55:34.0325Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:55:31.208188Z","time spent":"2.824301495s","remote":"127.0.0.1:43962","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":121,"response size":29,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true "}
{"level":"info","ts":"2026-05-09T16:55:34.032445Z","caller":"traceutil/trace.go:171","msg":"trace[228533589] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1177; }","duration":"4.005695821s","start":"2026-05-09T16:55:30.026724Z","end":"2026-05-09T16:55:34.03242Z","steps":["trace[228533589] 'agreement among raft nodes before linearized reading'  (duration: 4.005446436s)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:55:34.032574Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:55:30.026705Z","time spent":"4.005855606s","remote":"127.0.0.1:43736","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-05-09T16:55:34.032694Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.797212473s","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-05-09T16:55:34.032734Z","caller":"traceutil/trace.go:171","msg":"trace[1916476446] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:1177; }","duration":"2.797275635s","start":"2026-05-09T16:55:31.235446Z","end":"2026-05-09T16:55:34.032722Z","steps":["trace[1916476446] 'agreement among raft nodes before linearized reading'  (duration: 2.797217913s)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:55:34.032763Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:55:31.235435Z","time spent":"2.797320545s","remote":"127.0.0.1:38508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true "}
{"level":"warn","ts":"2026-05-09T16:55:34.032981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.80970831s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-05-09T16:55:34.033015Z","caller":"traceutil/trace.go:171","msg":"trace[1661360720] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1177; }","duration":"2.809782901s","start":"2026-05-09T16:55:31.223223Z","end":"2026-05-09T16:55:34.033006Z","steps":["trace[1661360720] 'agreement among raft nodes before linearized reading'  (duration: 2.809673779s)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:55:34.033048Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:55:31.223181Z","time spent":"2.809860753s","remote":"127.0.0.1:43736","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-05-09T16:55:34.033513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.559221463s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"info","ts":"2026-05-09T16:55:34.033554Z","caller":"traceutil/trace.go:171","msg":"trace[423049277] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1177; }","duration":"3.559286925s","start":"2026-05-09T16:55:30.474258Z","end":"2026-05-09T16:55:34.033545Z","steps":["trace[423049277] 'agreement among raft nodes before linearized reading'  (duration: 3.559191573s)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:55:34.033587Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:55:30.47424Z","time spent":"3.559341027s","remote":"127.0.0.1:43736","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-05-09T16:55:34.033746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.885534848s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"info","ts":"2026-05-09T16:55:34.033779Z","caller":"traceutil/trace.go:171","msg":"trace[708092151] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1177; }","duration":"2.885605859s","start":"2026-05-09T16:55:31.148166Z","end":"2026-05-09T16:55:34.033771Z","steps":["trace[708092151] 'agreement among raft nodes before linearized reading'  (duration: 2.885518277s)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:55:34.033809Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:55:31.148082Z","time spent":"2.885722022s","remote":"127.0.0.1:43736","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-05-09T16:55:34.034098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.628852005s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-09T16:55:34.034177Z","caller":"traceutil/trace.go:171","msg":"trace[2032583672] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1177; }","duration":"3.628976568s","start":"2026-05-09T16:55:30.40519Z","end":"2026-05-09T16:55:34.034166Z","steps":["trace[2032583672] 'agreement among raft nodes before linearized reading'  (duration: 3.628883556s)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:55:34.034207Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:55:30.405165Z","time spent":"3.629033189s","remote":"127.0.0.1:43712","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":27,"request content":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true "}
{"level":"warn","ts":"2026-05-09T16:55:34.034496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.946814176s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-09T16:55:34.034533Z","caller":"traceutil/trace.go:171","msg":"trace[448022579] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1177; }","duration":"1.946865887s","start":"2026-05-09T16:55:32.087658Z","end":"2026-05-09T16:55:34.034524Z","steps":["trace[448022579] 'agreement among raft nodes before linearized reading'  (duration: 1.946813036s)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:55:34.03456Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:55:32.087651Z","time spent":"1.946903718s","remote":"127.0.0.1:43490","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-05-09T16:55:34.034554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.753388553s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-05-09T16:55:34.034606Z","caller":"traceutil/trace.go:171","msg":"trace[1176314246] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1177; }","duration":"2.753478646s","start":"2026-05-09T16:55:31.281115Z","end":"2026-05-09T16:55:34.034593Z","steps":["trace[1176314246] 'agreement among raft nodes before linearized reading'  (duration: 2.753290181s)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:55:34.034643Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:55:31.281088Z","time spent":"2.753549008s","remote":"127.0.0.1:43736","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-05-09T16:55:34.034609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.947066992s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/kube-apiserver-instance.18adf3ef98a5dae4\" ","response":"range_response_count:1 size:774"}
{"level":"warn","ts":"2026-05-09T16:55:34.034756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.705361591s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.162\" ","response":"range_response_count:1 size:135"}
{"level":"warn","ts":"2026-05-09T16:55:34.034794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.961402422s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-05-09T16:55:34.034821Z","caller":"traceutil/trace.go:171","msg":"trace[1689619082] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:1177; }","duration":"1.961474854s","start":"2026-05-09T16:55:32.07334Z","end":"2026-05-09T16:55:34.034815Z","steps":["trace[1689619082] 'agreement among raft nodes before linearized reading'  (duration: 1.961428703s)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:55:34.034844Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:55:32.073315Z","time spent":"1.961524405s","remote":"127.0.0.1:43866","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":29,"request content":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true "}
{"level":"info","ts":"2026-05-09T16:55:34.034856Z","caller":"traceutil/trace.go:171","msg":"trace[954868632] range","detail":"{range_begin:/registry/events/kube-system/kube-apiserver-instance.18adf3ef98a5dae4; range_end:; response_count:1; response_revision:1177; }","duration":"1.947191865s","start":"2026-05-09T16:55:32.087497Z","end":"2026-05-09T16:55:34.034689Z","steps":["trace[954868632] 'agreement among raft nodes before linearized reading'  (duration: 1.94697634s)"],"step_count":1}
{"level":"info","ts":"2026-05-09T16:55:34.034791Z","caller":"traceutil/trace.go:171","msg":"trace[212618187] range","detail":"{range_begin:/registry/masterleases/199.204.45.162; range_end:; response_count:1; response_revision:1177; }","duration":"1.705429772s","start":"2026-05-09T16:55:32.329353Z","end":"2026-05-09T16:55:34.034782Z","steps":["trace[212618187] 'agreement among raft nodes before linearized reading'  (duration: 1.70534778s)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:55:34.034948Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:55:32.329331Z","time spent":"1.705608296s","remote":"127.0.0.1:43534","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.204.45.162\" "}
{"level":"warn","ts":"2026-05-09T16:55:34.034941Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:55:32.087479Z","time spent":"1.9474251s","remote":"127.0.0.1:43574","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":796,"request content":"key:\"/registry/events/kube-system/kube-apiserver-instance.18adf3ef98a5dae4\" "}
{"level":"info","ts":"2026-05-09T16:55:48.228855Z","caller":"traceutil/trace.go:171","msg":"trace[890745439] linearizableReadLoop","detail":"{readStateIndex:1273; appliedIndex:1272; }","duration":"115.810097ms","start":"2026-05-09T16:55:48.113003Z","end":"2026-05-09T16:55:48.228813Z","steps":["trace[890745439] 'read index received'  (duration: 115.576311ms)","trace[890745439] 'applied index is now lower than readState.Index'  (duration: 232.276µs)"],"step_count":2}
{"level":"info","ts":"2026-05-09T16:55:48.228883Z","caller":"traceutil/trace.go:171","msg":"trace[424746163] transaction","detail":"{read_only:false; response_revision:1225; number_of_response:1; }","duration":"143.336809ms","start":"2026-05-09T16:55:48.085514Z","end":"2026-05-09T16:55:48.22885Z","steps":["trace[424746163] 'process raft request'  (duration: 143.138315ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:55:48.229134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.683969ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-05-09T16:55:48.229208Z","caller":"traceutil/trace.go:171","msg":"trace[224747604] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1225; }","duration":"111.803812ms","start":"2026-05-09T16:55:48.117387Z","end":"2026-05-09T16:55:48.229191Z","steps":["trace[224747604] 'agreement among raft nodes before linearized reading'  (duration: 111.626507ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:55:48.229266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.693634ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"info","ts":"2026-05-09T16:55:48.229323Z","caller":"traceutil/trace.go:171","msg":"trace[1434168359] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1225; }","duration":"107.759235ms","start":"2026-05-09T16:55:48.12155Z","end":"2026-05-09T16:55:48.22931Z","steps":["trace[1434168359] 'agreement among raft nodes before linearized reading'  (duration: 107.645073ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:55:48.229361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.202957ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"warn","ts":"2026-05-09T16:55:48.229149Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.132474ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-05-09T16:55:48.22939Z","caller":"traceutil/trace.go:171","msg":"trace[1414111792] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1225; }","duration":"111.247738ms","start":"2026-05-09T16:55:48.118134Z","end":"2026-05-09T16:55:48.229382Z","steps":["trace[1414111792] 'agreement among raft nodes before linearized reading'  (duration: 111.169446ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T16:55:48.229421Z","caller":"traceutil/trace.go:171","msg":"trace[101467416] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1225; }","duration":"116.448062ms","start":"2026-05-09T16:55:48.112951Z","end":"2026-05-09T16:55:48.229399Z","steps":["trace[101467416] 'agreement among raft nodes before linearized reading'  (duration: 116.045242ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:55:48.229499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.841218ms","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-05-09T16:55:48.22954Z","caller":"traceutil/trace.go:171","msg":"trace[741747594] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1225; }","duration":"107.91984ms","start":"2026-05-09T16:55:48.12161Z","end":"2026-05-09T16:55:48.22953Z","steps":["trace[741747594] 'agreement among raft nodes before linearized reading'  (duration: 107.820497ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:55:50.433086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"979.444486ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14085744566051009653 > lease_revoke:<id:437a9e0da85bf3f9>","response":"size:27"}
{"level":"info","ts":"2026-05-09T16:55:50.433205Z","caller":"traceutil/trace.go:171","msg":"trace[1598713728] linearizableReadLoop","detail":"{readStateIndex:1279; appliedIndex:1278; }","duration":"338.6364ms","start":"2026-05-09T16:55:50.094537Z","end":"2026-05-09T16:55:50.433173Z","steps":["trace[1598713728] 'read index received'  (duration: 36.591µs)","trace[1598713728] 'applied index is now lower than readState.Index'  (duration: 338.597928ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T16:55:50.433409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.847674ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-05-09T16:55:50.433405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"426.120204ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-09T16:55:50.433539Z","caller":"traceutil/trace.go:171","msg":"trace[102015845] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1230; }","duration":"426.263718ms","start":"2026-05-09T16:55:50.007261Z","end":"2026-05-09T16:55:50.433525Z","steps":["trace[102015845] 'range keys from in-memory index tree'  (duration: 426.106244ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T16:55:50.433917Z","caller":"traceutil/trace.go:171","msg":"trace[1251567967] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:1230; }","duration":"338.980008ms","start":"2026-05-09T16:55:50.094503Z","end":"2026-05-09T16:55:50.433483Z","steps":["trace[1251567967] 'agreement among raft nodes before linearized reading'  (duration: 338.822784ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:55:50.433972Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:55:50.094487Z","time spent":"339.476859ms","remote":"127.0.0.1:38542","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "}
{"level":"info","ts":"2026-05-09T16:55:50.697859Z","caller":"traceutil/trace.go:171","msg":"trace[397920436] linearizableReadLoop","detail":"{readStateIndex:1280; appliedIndex:1279; }","duration":"264.601185ms","start":"2026-05-09T16:55:50.433233Z","end":"2026-05-09T16:55:50.697835Z","steps":["trace[397920436] 'read index received'  (duration: 264.39258ms)","trace[397920436] 'applied index is now lower than readState.Index'  (duration: 207.445µs)"],"step_count":2}
{"level":"info","ts":"2026-05-09T16:55:50.697992Z","caller":"traceutil/trace.go:171","msg":"trace[64691984] transaction","detail":"{read_only:false; response_revision:1231; number_of_response:1; }","duration":"462.521908ms","start":"2026-05-09T16:55:50.235443Z","end":"2026-05-09T16:55:50.697965Z","steps":["trace[64691984] 'process raft request'  (duration: 462.231641ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:55:50.698104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.1777ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"warn","ts":"2026-05-09T16:55:50.698095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"420.969532ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"info","ts":"2026-05-09T16:55:50.698144Z","caller":"traceutil/trace.go:171","msg":"trace[958698489] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:1231; }","duration":"368.244562ms","start":"2026-05-09T16:55:50.329889Z","end":"2026-05-09T16:55:50.698134Z","steps":["trace[958698489] 'agreement among raft nodes before linearized reading'  (duration: 368.17152ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T16:55:50.698163Z","caller":"traceutil/trace.go:171","msg":"trace[1437222814] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1231; }","duration":"421.068654ms","start":"2026-05-09T16:55:50.277076Z","end":"2026-05-09T16:55:50.698145Z","steps":["trace[1437222814] 'agreement among raft nodes before linearized reading'  (duration: 420.89326ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:55:50.698184Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:55:50.329875Z","time spent":"368.302103ms","remote":"127.0.0.1:43606","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":17,"response size":29,"request content":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true "}
{"level":"warn","ts":"2026-05-09T16:55:50.698171Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:55:50.235416Z","time spent":"462.6399ms","remote":"127.0.0.1:43736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:1225 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:458 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"warn","ts":"2026-05-09T16:55:50.698196Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:55:50.277068Z","time spent":"421.122365ms","remote":"127.0.0.1:43736","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-05-09T16:55:50.69818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"421.023483ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"warn","ts":"2026-05-09T16:55:50.698195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"421.355341ms","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-05-09T16:55:50.698249Z","caller":"traceutil/trace.go:171","msg":"trace[626731957] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1231; }","duration":"421.116605ms","start":"2026-05-09T16:55:50.277115Z","end":"2026-05-09T16:55:50.698231Z","steps":["trace[626731957] 'agreement among raft nodes before linearized reading'  (duration: 420.89234ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:55:50.698286Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:55:50.27711Z","time spent":"421.168836ms","remote":"127.0.0.1:43736","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-05-09T16:55:50.698279Z","caller":"traceutil/trace.go:171","msg":"trace[545676650] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1231; }","duration":"421.472544ms","start":"2026-05-09T16:55:50.276783Z","end":"2026-05-09T16:55:50.698256Z","steps":["trace[545676650] 'agreement among raft nodes before linearized reading'  (duration: 421.267119ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:55:50.698321Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:55:50.276762Z","time spent":"421.548365ms","remote":"127.0.0.1:43736","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-05-09T16:55:50.698533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"424.355832ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-05-09T16:55:50.69856Z","caller":"traceutil/trace.go:171","msg":"trace[601313826] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1231; }","duration":"424.934926ms","start":"2026-05-09T16:55:50.273617Z","end":"2026-05-09T16:55:50.698552Z","steps":["trace[601313826] 'agreement among raft nodes before linearized reading'  (duration: 424.305611ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:55:50.698582Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:55:50.273595Z","time spent":"424.979827ms","remote":"127.0.0.1:43736","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-05-09T16:55:50.698587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"421.023894ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-05-09T16:55:50.698632Z","caller":"traceutil/trace.go:171","msg":"trace[314045095] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1231; }","duration":"421.090305ms","start":"2026-05-09T16:55:50.277533Z","end":"2026-05-09T16:55:50.698623Z","steps":["trace[314045095] 'agreement among raft nodes before linearized reading'  (duration: 420.366587ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:55:50.698699Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:55:50.277524Z","time spent":"421.169746ms","remote":"127.0.0.1:43736","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-05-09T16:55:54.628486Z","caller":"traceutil/trace.go:171","msg":"trace[83668033] transaction","detail":"{read_only:false; response_revision:1265; number_of_response:1; }","duration":"426.610856ms","start":"2026-05-09T16:55:54.201849Z","end":"2026-05-09T16:55:54.62846Z","steps":["trace[83668033] 'process raft request'  (duration: 426.463003ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:55:54.628636Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:55:54.20183Z","time spent":"426.72764ms","remote":"127.0.0.1:43736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:1217 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:471 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"info","ts":"2026-05-09T16:55:54.839554Z","caller":"traceutil/trace.go:171","msg":"trace[904908842] linearizableReadLoop","detail":"{readStateIndex:1316; appliedIndex:1315; }","duration":"115.54314ms","start":"2026-05-09T16:55:54.723988Z","end":"2026-05-09T16:55:54.839531Z","steps":["trace[904908842] 'read index received'  (duration: 115.324134ms)","trace[904908842] 'applied index is now lower than readState.Index'  (duration: 217.895µs)"],"step_count":2}
{"level":"info","ts":"2026-05-09T16:55:54.839615Z","caller":"traceutil/trace.go:171","msg":"trace[569761329] transaction","detail":"{read_only:false; response_revision:1266; number_of_response:1; }","duration":"125.942577ms","start":"2026-05-09T16:55:54.713638Z","end":"2026-05-09T16:55:54.83958Z","steps":["trace[569761329] 'process raft request'  (duration: 125.688701ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:55:54.839939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.929069ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-05-09T16:55:54.839987Z","caller":"traceutil/trace.go:171","msg":"trace[342968729] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1266; }","duration":"116.040952ms","start":"2026-05-09T16:55:54.723935Z","end":"2026-05-09T16:55:54.839976Z","steps":["trace[342968729] 'agreement among raft nodes before linearized reading'  (duration: 115.721414ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:55:54.871199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.93495ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-05-09T16:55:54.871234Z","caller":"traceutil/trace.go:171","msg":"trace[1324750347] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1267; }","duration":"145.996932ms","start":"2026-05-09T16:55:54.725229Z","end":"2026-05-09T16:55:54.871226Z","steps":["trace[1324750347] 'agreement among raft nodes before linearized reading'  (duration: 145.88075ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:55:54.871309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.737362ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-05-09T16:55:54.871405Z","caller":"traceutil/trace.go:171","msg":"trace[1753225897] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1267; }","duration":"141.865544ms","start":"2026-05-09T16:55:54.729517Z","end":"2026-05-09T16:55:54.871382Z","steps":["trace[1753225897] 'agreement among raft nodes before linearized reading'  (duration: 141.599358ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:55:54.871472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.979481ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"warn","ts":"2026-05-09T16:55:54.871448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.36015ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-05-09T16:55:54.871563Z","caller":"traceutil/trace.go:171","msg":"trace[992966251] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1267; }","duration":"143.104874ms","start":"2026-05-09T16:55:54.728445Z","end":"2026-05-09T16:55:54.87155Z","steps":["trace[992966251] 'agreement among raft nodes before linearized reading'  (duration: 142.855268ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T16:55:54.871598Z","caller":"traceutil/trace.go:171","msg":"trace[727301571] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1267; }","duration":"143.528044ms","start":"2026-05-09T16:55:54.728048Z","end":"2026-05-09T16:55:54.871577Z","steps":["trace[727301571] 'agreement among raft nodes before linearized reading'  (duration: 143.295718ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T16:55:55.037588Z","caller":"traceutil/trace.go:171","msg":"trace[1295845190] transaction","detail":"{read_only:false; response_revision:1268; number_of_response:1; }","duration":"193.085999ms","start":"2026-05-09T16:55:54.844478Z","end":"2026-05-09T16:55:55.037564Z","steps":["trace[1295845190] 'process raft request'  (duration: 155.573509ms)","trace[1295845190] 'compare'  (duration: 37.398947ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T16:55:55.33444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.834687ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14085744566051009723 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:1261 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-09T16:55:55.334792Z","caller":"traceutil/trace.go:171","msg":"trace[1282663178] transaction","detail":"{read_only:false; response_revision:1269; number_of_response:1; }","duration":"459.004214ms","start":"2026-05-09T16:55:54.875754Z","end":"2026-05-09T16:55:55.334758Z","steps":["trace[1282663178] 'process raft request'  (duration: 272.739697ms)","trace[1282663178] 'compare'  (duration: 185.725995ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T16:55:55.335194Z","caller":"traceutil/trace.go:171","msg":"trace[1488000131] transaction","detail":"{read_only:false; response_revision:1270; number_of_response:1; }","duration":"457.298714ms","start":"2026-05-09T16:55:54.87787Z","end":"2026-05-09T16:55:55.335169Z","steps":["trace[1488000131] 'process raft request'  (duration: 457.008487ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T16:55:55.335247Z","caller":"traceutil/trace.go:171","msg":"trace[1802157228] linearizableReadLoop","detail":"{readStateIndex:1322; appliedIndex:1317; }","duration":"431.528234ms","start":"2026-05-09T16:55:54.903699Z","end":"2026-05-09T16:55:55.335227Z","steps":["trace[1802157228] 'read index received'  (duration: 96.380606ms)","trace[1802157228] 'applied index is now lower than readState.Index'  (duration: 335.146688ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T16:55:55.335238Z","caller":"traceutil/trace.go:171","msg":"trace[1393324858] transaction","detail":"{read_only:false; response_revision:1271; number_of_response:1; }","duration":"457.302164ms","start":"2026-05-09T16:55:54.8779Z","end":"2026-05-09T16:55:55.335202Z","steps":["trace[1393324858] 'process raft request'  (duration: 457.182211ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:55:55.335321Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:55:54.877855Z","time spent":"457.397296ms","remote":"127.0.0.1:43736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:1259 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-05-09T16:55:55.335337Z","caller":"traceutil/trace.go:171","msg":"trace[2002755520] transaction","detail":"{read_only:false; response_revision:1273; number_of_response:1; }","duration":"229.222695ms","start":"2026-05-09T16:55:55.106086Z","end":"2026-05-09T16:55:55.335309Z","steps":["trace[2002755520] 'process raft request'  (duration: 229.106923ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:55:55.335008Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:55:54.875731Z","time spent":"459.161569ms","remote":"127.0.0.1:43736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:1261 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-05-09T16:55:55.335489Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:55:54.877871Z","time spent":"457.450488ms","remote":"127.0.0.1:43736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:1260 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-05-09T16:55:55.335397Z","caller":"traceutil/trace.go:171","msg":"trace[1682145975] transaction","detail":"{read_only:false; response_revision:1272; number_of_response:1; }","duration":"457.448858ms","start":"2026-05-09T16:55:54.877931Z","end":"2026-05-09T16:55:55.33538Z","steps":["trace[1682145975] 'process raft request'  (duration: 457.210072ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:55:55.335586Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:55:54.877921Z","time spent":"457.639702ms","remote":"127.0.0.1:43736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:1258 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-05-09T16:55:55.335678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"431.932203ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-09T16:55:55.335733Z","caller":"traceutil/trace.go:171","msg":"trace[2053610676] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:0; response_revision:1273; }","duration":"432.054986ms","start":"2026-05-09T16:55:54.903667Z","end":"2026-05-09T16:55:55.335722Z","steps":["trace[2053610676] 'agreement among raft nodes before linearized reading'  (duration: 431.81085ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:55:55.336483Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:55:54.903652Z","time spent":"432.815124ms","remote":"127.0.0.1:43736","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":0,"response size":27,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "}
{"level":"warn","ts":"2026-05-09T16:55:55.354382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.949389ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-09T16:55:55.354461Z","caller":"traceutil/trace.go:171","msg":"trace[51844788] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1274; }","duration":"272.119443ms","start":"2026-05-09T16:55:55.082324Z","end":"2026-05-09T16:55:55.354443Z","steps":["trace[51844788] 'agreement among raft nodes before linearized reading'  (duration: 271.635372ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:55:55.855874Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14085744566051009732,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-05-09T16:55:56.07056Z","caller":"traceutil/trace.go:171","msg":"trace[2054864265] linearizableReadLoop","detail":"{readStateIndex:1326; appliedIndex:1324; }","duration":"715.059387ms","start":"2026-05-09T16:55:55.355477Z","end":"2026-05-09T16:55:56.070536Z","steps":["trace[2054864265] 'read index received'  (duration: 714.806911ms)","trace[2054864265] 'applied index is now lower than readState.Index'  (duration: 251.336µs)"],"step_count":2}
{"level":"info","ts":"2026-05-09T16:55:56.070629Z","caller":"traceutil/trace.go:171","msg":"trace[433815364] transaction","detail":"{read_only:false; response_revision:1276; number_of_response:1; }","duration":"730.562705ms","start":"2026-05-09T16:55:55.340029Z","end":"2026-05-09T16:55:56.070592Z","steps":["trace[433815364] 'process raft request'  (duration: 730.457263ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T16:55:56.070664Z","caller":"traceutil/trace.go:171","msg":"trace[749649474] transaction","detail":"{read_only:false; response_revision:1275; number_of_response:1; }","duration":"731.930938ms","start":"2026-05-09T16:55:55.338719Z","end":"2026-05-09T16:55:56.07065Z","steps":["trace[749649474] 'process raft request'  (duration: 731.62096ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:55:56.070733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"715.240041ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-05-09T16:55:56.070768Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:55:55.340018Z","time spent":"730.677918ms","remote":"127.0.0.1:43736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":459,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" mod_revision:0 > success:<request_put:<key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" value_size:406 >> failure:<>"}
{"level":"info","ts":"2026-05-09T16:55:56.070779Z","caller":"traceutil/trace.go:171","msg":"trace[1909758216] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1276; }","duration":"715.320603ms","start":"2026-05-09T16:55:55.355446Z","end":"2026-05-09T16:55:56.070766Z","steps":["trace[1909758216] 'agreement among raft nodes before linearized reading'  (duration: 715.217701ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:55:56.070813Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:55:55.355433Z","time spent":"715.372504ms","remote":"127.0.0.1:43506","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-05-09T16:55:56.07074Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:55:55.338693Z","time spent":"732.001509ms","remote":"127.0.0.1:43574","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":836,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-m4dcc.18adf40accd01973\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-m4dcc.18adf40accd01973\" value_size:732 lease:4862372529196233659 >> failure:<>"}
{"level":"warn","ts":"2026-05-09T16:55:56.070872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.950097ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-09T16:55:56.07096Z","caller":"traceutil/trace.go:171","msg":"trace[1145067283] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:1276; }","duration":"145.0582ms","start":"2026-05-09T16:55:55.925882Z","end":"2026-05-09T16:55:56.07094Z","steps":["trace[1145067283] 'agreement among raft nodes before linearized reading'  (duration: 144.896086ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:55:57.225773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"853.770657ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14085744566051009736 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/kube-system/rbd-csi-ceph-com.18adf40b0691793a\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/rbd-csi-ceph-com.18adf40b0691793a\" value_size:693 lease:4862372529196233659 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-05-09T16:55:57.225852Z","caller":"traceutil/trace.go:171","msg":"trace[146525243] linearizableReadLoop","detail":"{readStateIndex:1327; appliedIndex:1326; }","duration":"1.143264302s","start":"2026-05-09T16:55:56.082574Z","end":"2026-05-09T16:55:57.225838Z","steps":["trace[146525243] 'read index received'  (duration: 289.372392ms)","trace[146525243] 'applied index is now lower than readState.Index'  (duration: 853.89016ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T16:55:57.225873Z","caller":"traceutil/trace.go:171","msg":"trace[1567575393] transaction","detail":"{read_only:false; response_revision:1277; number_of_response:1; }","duration":"1.14993715s","start":"2026-05-09T16:55:56.075914Z","end":"2026-05-09T16:55:57.225852Z","steps":["trace[1567575393] 'process raft request'  (duration: 296.03891ms)","trace[1567575393] 'compare'  (duration: 853.539421ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T16:55:57.225935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.143357465s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-09T16:55:57.225951Z","caller":"traceutil/trace.go:171","msg":"trace[234391292] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1277; }","duration":"1.143395875s","start":"2026-05-09T16:55:56.082549Z","end":"2026-05-09T16:55:57.225945Z","steps":["trace[234391292] 'agreement among raft nodes before linearized reading'  (duration: 1.143340334s)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:55:57.225947Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:55:56.075891Z","time spent":"1.150022012s","remote":"127.0.0.1:43574","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":773,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/rbd-csi-ceph-com.18adf40b0691793a\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/rbd-csi-ceph-com.18adf40b0691793a\" value_size:693 lease:4862372529196233659 >> failure:<>"}
{"level":"warn","ts":"2026-05-09T16:55:57.225967Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:55:56.082541Z","time spent":"1.143422756s","remote":"127.0.0.1:43490","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-05-09T16:55:57.272905Z","caller":"traceutil/trace.go:171","msg":"trace[250071177] transaction","detail":"{read_only:false; response_revision:1278; number_of_response:1; }","duration":"1.190015131s","start":"2026-05-09T16:55:56.082867Z","end":"2026-05-09T16:55:57.272882Z","steps":["trace[250071177] 'process raft request'  (duration: 1.189902238s)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:55:57.273096Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:55:56.082847Z","time spent":"1.190127993s","remote":"127.0.0.1:43736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":458,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" mod_revision:1276 > success:<request_put:<key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" value_size:405 >> failure:<request_range:<key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" > >"}
{"level":"warn","ts":"2026-05-09T16:55:57.302223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"693.327282ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-05-09T16:55:57.302295Z","caller":"traceutil/trace.go:171","msg":"trace[1877368946] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:1279; }","duration":"693.451624ms","start":"2026-05-09T16:55:56.608826Z","end":"2026-05-09T16:55:57.302278Z","steps":["trace[1877368946] 'agreement among raft nodes before linearized reading'  (duration: 693.336492ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:55:57.302298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.350048ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"warn","ts":"2026-05-09T16:55:57.30234Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:55:56.608804Z","time spent":"693.523767ms","remote":"127.0.0.1:43674","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":5,"response size":29,"request content":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true "}
{"level":"info","ts":"2026-05-09T16:55:57.302394Z","caller":"traceutil/trace.go:171","msg":"trace[1319598782] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1279; }","duration":"261.471031ms","start":"2026-05-09T16:55:57.040868Z","end":"2026-05-09T16:55:57.302339Z","steps":["trace[1319598782] 'agreement among raft nodes before linearized reading'  (duration: 261.291637ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T16:55:57.302574Z","caller":"traceutil/trace.go:171","msg":"trace[144605319] transaction","detail":"{read_only:false; response_revision:1279; number_of_response:1; }","duration":"457.373336ms","start":"2026-05-09T16:55:56.845189Z","end":"2026-05-09T16:55:57.302562Z","steps":["trace[144605319] 'process raft request'  (duration: 456.810423ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:55:57.302661Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:55:56.845162Z","time spent":"457.445068ms","remote":"127.0.0.1:43736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:1266 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"warn","ts":"2026-05-09T16:55:57.643927Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.493359ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14085744566051009749 > lease_revoke:<id:437a9e0da85bf444>","response":"size:27"}
{"level":"info","ts":"2026-05-09T16:55:59.697127Z","caller":"traceutil/trace.go:171","msg":"trace[1165852268] linearizableReadLoop","detail":"{readStateIndex:1338; appliedIndex:1337; }","duration":"294.061833ms","start":"2026-05-09T16:55:59.403037Z","end":"2026-05-09T16:55:59.697098Z","steps":["trace[1165852268] 'read index received'  (duration: 293.781526ms)","trace[1165852268] 'applied index is now lower than readState.Index'  (duration: 279.007µs)"],"step_count":2}
{"level":"info","ts":"2026-05-09T16:55:59.697204Z","caller":"traceutil/trace.go:171","msg":"trace[805786373] transaction","detail":"{read_only:false; response_revision:1287; number_of_response:1; }","duration":"313.372061ms","start":"2026-05-09T16:55:59.383813Z","end":"2026-05-09T16:55:59.697185Z","steps":["trace[805786373] 'process raft request'  (duration: 313.099545ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:55:59.697304Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:55:59.3838Z","time spent":"313.443873ms","remote":"127.0.0.1:43736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:1281 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-05-09T16:55:59.697372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.32458ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"warn","ts":"2026-05-09T16:55:59.6974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.139996ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-05-09T16:55:59.697455Z","caller":"traceutil/trace.go:171","msg":"trace[2136420721] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1287; }","duration":"294.442113ms","start":"2026-05-09T16:55:59.402984Z","end":"2026-05-09T16:55:59.697427Z","steps":["trace[2136420721] 'agreement among raft nodes before linearized reading'  (duration: 294.219657ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T16:55:59.697459Z","caller":"traceutil/trace.go:171","msg":"trace[813895057] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1287; }","duration":"294.218667ms","start":"2026-05-09T16:55:59.403222Z","end":"2026-05-09T16:55:59.69744Z","steps":["trace[813895057] 'agreement among raft nodes before linearized reading'  (duration: 294.036123ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:55:59.697633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.993498ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-05-09T16:55:59.6977Z","caller":"traceutil/trace.go:171","msg":"trace[1332784631] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1287; }","duration":"293.092591ms","start":"2026-05-09T16:55:59.404591Z","end":"2026-05-09T16:55:59.697684Z","steps":["trace[1332784631] 'agreement among raft nodes before linearized reading'  (duration: 292.763573ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T16:56:00.744056Z","caller":"traceutil/trace.go:171","msg":"trace[1305191096] transaction","detail":"{read_only:false; response_revision:1291; number_of_response:1; }","duration":"312.395858ms","start":"2026-05-09T16:56:00.431157Z","end":"2026-05-09T16:56:00.743553Z","steps":["trace[1305191096] 'process raft request'  (duration: 312.198923ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:56:00.744221Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:56:00.431128Z","time spent":"313.007623ms","remote":"127.0.0.1:43654","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6105,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:1262 > success:<request_put:<key:\"/registry/minions/instance\" value_size:6071 >> failure:<request_range:<key:\"/registry/minions/instance\" > >"}
{"level":"info","ts":"2026-05-09T16:56:04.257221Z","caller":"traceutil/trace.go:171","msg":"trace[357520110] transaction","detail":"{read_only:false; response_revision:1308; number_of_response:1; }","duration":"195.939896ms","start":"2026-05-09T16:56:04.061257Z","end":"2026-05-09T16:56:04.257197Z","steps":["trace[357520110] 'process raft request'  (duration: 195.843564ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T16:56:04.257356Z","caller":"traceutil/trace.go:171","msg":"trace[1013597291] linearizableReadLoop","detail":"{readStateIndex:1360; appliedIndex:1360; }","duration":"174.884797ms","start":"2026-05-09T16:56:04.082438Z","end":"2026-05-09T16:56:04.257323Z","steps":["trace[1013597291] 'read index received'  (duration: 174.868307ms)","trace[1013597291] 'applied index is now lower than readState.Index'  (duration: 13.97µs)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T16:56:04.257454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.010791ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-09T16:56:04.257483Z","caller":"traceutil/trace.go:171","msg":"trace[814625742] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1308; }","duration":"175.092953ms","start":"2026-05-09T16:56:04.082383Z","end":"2026-05-09T16:56:04.257476Z","steps":["trace[814625742] 'agreement among raft nodes before linearized reading'  (duration: 175.024171ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:56:14.851023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.146271ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"}
{"level":"info","ts":"2026-05-09T16:56:14.8511Z","caller":"traceutil/trace.go:171","msg":"trace[529191689] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1377; }","duration":"368.269204ms","start":"2026-05-09T16:56:14.482811Z","end":"2026-05-09T16:56:14.85108Z","steps":["trace[529191689] 'range keys from in-memory index tree'  (duration: 367.981506ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:56:14.851142Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:56:14.48279Z","time spent":"368.343925ms","remote":"127.0.0.1:43736","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":554,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "}
{"level":"info","ts":"2026-05-09T16:56:15.002873Z","caller":"traceutil/trace.go:171","msg":"trace[920804641] transaction","detail":"{read_only:false; response_revision:1378; number_of_response:1; }","duration":"147.510758ms","start":"2026-05-09T16:56:14.855324Z","end":"2026-05-09T16:56:15.002834Z","steps":["trace[920804641] 'process raft request'  (duration: 147.361854ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:56:20.170018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.523654ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-09T16:56:20.170231Z","caller":"traceutil/trace.go:171","msg":"trace[1929644957] transaction","detail":"{read_only:false; response_revision:1402; number_of_response:1; }","duration":"286.373081ms","start":"2026-05-09T16:56:19.883832Z","end":"2026-05-09T16:56:20.170205Z","steps":["trace[1929644957] 'process raft request'  (duration: 243.28954ms)","trace[1929644957] 'compare'  (duration: 42.989239ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T16:56:20.170296Z","caller":"traceutil/trace.go:171","msg":"trace[1379973357] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1401; }","duration":"162.831851ms","start":"2026-05-09T16:56:20.007444Z","end":"2026-05-09T16:56:20.170276Z","steps":["trace[1379973357] 'range keys from in-memory index tree'  (duration: 162.502473ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T16:56:20.205289Z","caller":"traceutil/trace.go:171","msg":"trace[829903120] transaction","detail":"{read_only:false; response_revision:1403; number_of_response:1; }","duration":"321.205197ms","start":"2026-05-09T16:56:19.88406Z","end":"2026-05-09T16:56:20.205265Z","steps":["trace[829903120] 'process raft request'  (duration: 321.049773ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:56:20.205526Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:56:19.884038Z","time spent":"321.379712ms","remote":"127.0.0.1:43736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:1393 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-05-09T16:56:20.205507Z","caller":"traceutil/trace.go:171","msg":"trace[1491779630] linearizableReadLoop","detail":"{readStateIndex:1459; appliedIndex:1456; }","duration":"268.981899ms","start":"2026-05-09T16:56:19.936498Z","end":"2026-05-09T16:56:20.20548Z","steps":["trace[1491779630] 'read index received'  (duration: 190.636541ms)","trace[1491779630] 'applied index is now lower than readState.Index'  (duration: 78.343308ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T16:56:20.205556Z","caller":"traceutil/trace.go:171","msg":"trace[1130882230] transaction","detail":"{read_only:false; response_revision:1404; number_of_response:1; }","duration":"321.225898ms","start":"2026-05-09T16:56:19.884311Z","end":"2026-05-09T16:56:20.205536Z","steps":["trace[1130882230] 'process raft request'  (duration: 320.9188ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:56:20.205721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.179724ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/servicenodeports\" ","response":"range_response_count:1 size:118"}
{"level":"info","ts":"2026-05-09T16:56:20.205799Z","caller":"traceutil/trace.go:171","msg":"trace[1372201034] range","detail":"{range_begin:/registry/ranges/servicenodeports; range_end:; response_count:1; response_revision:1404; }","duration":"269.314877ms","start":"2026-05-09T16:56:19.936447Z","end":"2026-05-09T16:56:20.205762Z","steps":["trace[1372201034] 'agreement among raft nodes before linearized reading'  (duration: 269.130623ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:56:20.205917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.837508ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:115638"}
{"level":"warn","ts":"2026-05-09T16:56:20.205881Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:56:19.884302Z","time spent":"321.434402ms","remote":"127.0.0.1:43736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:1395 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-05-09T16:56:20.206216Z","caller":"traceutil/trace.go:171","msg":"trace[1992891280] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:1404; }","duration":"267.183636ms","start":"2026-05-09T16:56:19.939007Z","end":"2026-05-09T16:56:20.206191Z","steps":["trace[1992891280] 'agreement among raft nodes before linearized reading'  (duration: 266.726445ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:56:20.20637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.528222ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-09T16:56:20.207046Z","caller":"traceutil/trace.go:171","msg":"trace[2122054268] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1404; }","duration":"122.25751ms","start":"2026-05-09T16:56:20.084761Z","end":"2026-05-09T16:56:20.207018Z","steps":["trace[2122054268] 'agreement among raft nodes before linearized reading'  (duration: 121.484471ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T16:56:20.630134Z","caller":"traceutil/trace.go:171","msg":"trace[861036703] transaction","detail":"{read_only:false; response_revision:1405; number_of_response:1; }","duration":"157.104966ms","start":"2026-05-09T16:56:20.473004Z","end":"2026-05-09T16:56:20.630109Z","steps":["trace[861036703] 'process raft request'  (duration: 156.968443ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T16:56:49.400092Z","caller":"traceutil/trace.go:171","msg":"trace[192009068] linearizableReadLoop","detail":"{readStateIndex:1596; appliedIndex:1595; }","duration":"250.673968ms","start":"2026-05-09T16:56:49.149396Z","end":"2026-05-09T16:56:49.40007Z","steps":["trace[192009068] 'read index received'  (duration: 250.502884ms)","trace[192009068] 'applied index is now lower than readState.Index'  (duration: 169.814µs)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T16:56:49.400368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.956235ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:531"}
{"level":"info","ts":"2026-05-09T16:56:49.400415Z","caller":"traceutil/trace.go:171","msg":"trace[1700766630] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1535; }","duration":"251.057097ms","start":"2026-05-09T16:56:49.149345Z","end":"2026-05-09T16:56:49.400402Z","steps":["trace[1700766630] 'agreement among raft nodes before linearized reading'  (duration: 250.819342ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T16:56:49.400422Z","caller":"traceutil/trace.go:171","msg":"trace[514151160] transaction","detail":"{read_only:false; response_revision:1535; number_of_response:1; }","duration":"258.855581ms","start":"2026-05-09T16:56:49.141532Z","end":"2026-05-09T16:56:49.400387Z","steps":["trace[514151160] 'process raft request'  (duration: 258.3878ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T16:56:49.527689Z","caller":"traceutil/trace.go:171","msg":"trace[1430532913] linearizableReadLoop","detail":"{readStateIndex:1597; appliedIndex:1596; }","duration":"112.761225ms","start":"2026-05-09T16:56:49.414907Z","end":"2026-05-09T16:56:49.527668Z","steps":["trace[1430532913] 'read index received'  (duration: 88.019995ms)","trace[1430532913] 'applied index is now lower than readState.Index'  (duration: 24.74013ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T16:56:49.527875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.949689ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:508"}
{"level":"info","ts":"2026-05-09T16:56:49.527873Z","caller":"traceutil/trace.go:171","msg":"trace[523904051] transaction","detail":"{read_only:false; response_revision:1536; number_of_response:1; }","duration":"123.093537ms","start":"2026-05-09T16:56:49.404753Z","end":"2026-05-09T16:56:49.527846Z","steps":["trace[523904051] 'process raft request'  (duration: 98.182963ms)","trace[523904051] 'compare'  (duration: 24.640138ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T16:56:49.527915Z","caller":"traceutil/trace.go:171","msg":"trace[2107178408] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1536; }","duration":"113.039342ms","start":"2026-05-09T16:56:49.414864Z","end":"2026-05-09T16:56:49.527903Z","steps":["trace[2107178408] 'agreement among raft nodes before linearized reading'  (duration: 112.884978ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T16:57:14.41915Z","caller":"traceutil/trace.go:171","msg":"trace[379018031] transaction","detail":"{read_only:false; response_revision:1649; number_of_response:1; }","duration":"221.651829ms","start":"2026-05-09T16:57:14.197472Z","end":"2026-05-09T16:57:14.419124Z","steps":["trace[379018031] 'process raft request'  (duration: 221.504685ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T16:57:22.780256Z","caller":"traceutil/trace.go:171","msg":"trace[302307088] transaction","detail":"{read_only:false; response_revision:1689; number_of_response:1; }","duration":"116.203125ms","start":"2026-05-09T16:57:22.664009Z","end":"2026-05-09T16:57:22.780212Z","steps":["trace[302307088] 'process raft request'  (duration: 36.184218ms)","trace[302307088] 'compare'  (duration: 79.641898ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T16:57:28.090501Z","caller":"traceutil/trace.go:171","msg":"trace[1576698036] transaction","detail":"{read_only:false; response_revision:1714; number_of_response:1; }","duration":"118.063189ms","start":"2026-05-09T16:57:27.972405Z","end":"2026-05-09T16:57:28.090468Z","steps":["trace[1576698036] 'process raft request'  (duration: 117.870534ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T16:57:28.792563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.968434ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-09T16:57:28.792658Z","caller":"traceutil/trace.go:171","msg":"trace[2145225763] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:1715; }","duration":"120.077186ms","start":"2026-05-09T16:57:28.672562Z","end":"2026-05-09T16:57:28.792639Z","steps":["trace[2145225763] 'count revisions from in-memory index tree'  (duration: 119.884402ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T16:57:28.9112Z","caller":"traceutil/trace.go:171","msg":"trace[1008072862] transaction","detail":"{read_only:false; response_revision:1716; number_of_response:1; }","duration":"105.564195ms","start":"2026-05-09T16:57:28.805611Z","end":"2026-05-09T16:57:28.911175Z","steps":["trace[1008072862] 'process raft request'  (duration: 105.31952ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T16:57:29.055316Z","caller":"traceutil/trace.go:171","msg":"trace[217230263] transaction","detail":"{read_only:false; response_revision:1718; number_of_response:1; }","duration":"139.379869ms","start":"2026-05-09T16:57:28.915906Z","end":"2026-05-09T16:57:29.055286Z","steps":["trace[217230263] 'process raft request'  (duration: 86.594111ms)","trace[217230263] 'compare'  (duration: 52.619294ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T16:57:35.107893Z","caller":"traceutil/trace.go:171","msg":"trace[269155758] transaction","detail":"{read_only:false; response_revision:1745; number_of_response:1; }","duration":"111.46353ms","start":"2026-05-09T16:57:34.996402Z","end":"2026-05-09T16:57:35.107865Z","steps":["trace[269155758] 'process raft request'  (duration: 111.280165ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T16:59:14.900477Z","caller":"traceutil/trace.go:171","msg":"trace[1017570479] transaction","detail":"{read_only:false; response_revision:2236; number_of_response:1; }","duration":"125.234752ms","start":"2026-05-09T16:59:14.775221Z","end":"2026-05-09T16:59:14.900455Z","steps":["trace[1017570479] 'process raft request'  (duration: 101.526291ms)","trace[1017570479] 'compare'  (duration: 23.624499ms)"],"step_count":2}