{"level":"warn","ts":"2026-05-21T03:29:49.386236Z","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-21T03:29:49.386314Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.248:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.248:2380","--initial-cluster=instance=https://199.204.45.248:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.248:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.248:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]}
{"level":"warn","ts":"2026-05-21T03:29:49.386379Z","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-21T03:29:49.38639Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.248:2380"]}
{"level":"info","ts":"2026-05-21T03:29:49.386408Z","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-21T03:29:49.387037Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.248:2379"]}
{"level":"info","ts":"2026-05-21T03:29:49.387109Z","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.248:2380"],"listen-peer-urls":["https://199.204.45.248:2380"],"advertise-client-urls":["https://199.204.45.248:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.248:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.248:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"}
{"level":"info","ts":"2026-05-21T03:29:49.393064Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.760841ms"}
{"level":"info","ts":"2026-05-21T03:29:49.40703Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"39582465ceaa2f67","cluster-id":"87fd8ddedde3be45"}
{"level":"info","ts":"2026-05-21T03:29:49.407197Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 switched to configuration voters=()"}
{"level":"info","ts":"2026-05-21T03:29:49.407275Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became follower at term 0"}
{"level":"info","ts":"2026-05-21T03:29:49.407305Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 39582465ceaa2f67 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-05-21T03:29:49.407404Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became follower at term 1"}
{"level":"info","ts":"2026-05-21T03:29:49.407495Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 switched to configuration voters=(4132092677789986663)"}
{"level":"warn","ts":"2026-05-21T03:29:49.42316Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-05-21T03:29:49.426892Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-05-21T03:29:49.429075Z","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-21T03:29:49.43482Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"39582465ceaa2f67","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-05-21T03:29:49.436067Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"39582465ceaa2f67","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-05-21T03:29:49.436256Z","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-21T03:29:49.436299Z","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-21T03:29:49.436312Z","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-21T03:29:49.43846Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 switched to configuration voters=(4132092677789986663)"}
{"level":"info","ts":"2026-05-21T03:29:49.438675Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"87fd8ddedde3be45","local-member-id":"39582465ceaa2f67","added-peer-id":"39582465ceaa2f67","added-peer-peer-urls":["https://199.204.45.248:2380"]}
{"level":"info","ts":"2026-05-21T03:29:49.443809Z","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-21T03:29:49.444007Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.248:2380"}
{"level":"info","ts":"2026-05-21T03:29:49.444034Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.248:2380"}
{"level":"info","ts":"2026-05-21T03:29:49.444884Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"39582465ceaa2f67","initial-advertise-peer-urls":["https://199.204.45.248:2380"],"listen-peer-urls":["https://199.204.45.248:2380"],"advertise-client-urls":["https://199.204.45.248:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.248:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-05-21T03:29:49.444951Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-05-21T03:29:49.608302Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 is starting a new election at term 1"}
{"level":"info","ts":"2026-05-21T03:29:49.608382Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became pre-candidate at term 1"}
{"level":"info","ts":"2026-05-21T03:29:49.608421Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 received MsgPreVoteResp from 39582465ceaa2f67 at term 1"}
{"level":"info","ts":"2026-05-21T03:29:49.608446Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became candidate at term 2"}
{"level":"info","ts":"2026-05-21T03:29:49.608457Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 received MsgVoteResp from 39582465ceaa2f67 at term 2"}
{"level":"info","ts":"2026-05-21T03:29:49.608468Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became leader at term 2"}
{"level":"info","ts":"2026-05-21T03:29:49.608481Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 39582465ceaa2f67 elected leader 39582465ceaa2f67 at term 2"}
{"level":"info","ts":"2026-05-21T03:29:49.610573Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-21T03:29:49.611924Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"39582465ceaa2f67","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.248:2379]}","request-path":"/0/members/39582465ceaa2f67/attributes","cluster-id":"87fd8ddedde3be45","publish-timeout":"7s"}
{"level":"info","ts":"2026-05-21T03:29:49.61198Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-05-21T03:29:49.612038Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-05-21T03:29:49.612343Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-05-21T03:29:49.612384Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-05-21T03:29:49.612724Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"87fd8ddedde3be45","local-member-id":"39582465ceaa2f67","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-21T03:29:49.612834Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-21T03:29:49.612878Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-21T03:29:49.614346Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.248:2379"}
{"level":"info","ts":"2026-05-21T03:29:49.614711Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-05-21T03:30:24.995083Z","caller":"traceutil/trace.go:171","msg":"trace[1156556199] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"130.461096ms","start":"2026-05-21T03:30:24.864588Z","end":"2026-05-21T03:30:24.995049Z","steps":["trace[1156556199] 'process raft request'  (duration: 130.241071ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:30:25.619813Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.741852ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3415872876959589244 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:482 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-21T03:30:25.61994Z","caller":"traceutil/trace.go:171","msg":"trace[1877419426] linearizableReadLoop","detail":"{readStateIndex:542; appliedIndex:541; }","duration":"463.829586ms","start":"2026-05-21T03:30:25.156097Z","end":"2026-05-21T03:30:25.619926Z","steps":["trace[1877419426] 'read index received'  (duration: 126.285715ms)","trace[1877419426] 'applied index is now lower than readState.Index'  (duration: 337.542411ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-21T03:30:25.620144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"464.005351ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-21T03:30:25.620255Z","caller":"traceutil/trace.go:171","msg":"trace[52575324] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:522; }","duration":"464.174466ms","start":"2026-05-21T03:30:25.156056Z","end":"2026-05-21T03:30:25.620231Z","steps":["trace[52575324] 'agreement among raft nodes before linearized reading'  (duration: 463.98828ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:30:25.620303Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:30:25.156036Z","time spent":"464.258588ms","remote":"127.0.0.1:44610","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-05-21T03:30:25.620566Z","caller":"traceutil/trace.go:171","msg":"trace[2095167412] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"593.388152ms","start":"2026-05-21T03:30:25.02714Z","end":"2026-05-21T03:30:25.620528Z","steps":["trace[2095167412] 'process raft request'  (duration: 255.295186ms)","trace[2095167412] 'compare'  (duration: 336.588628ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-21T03:30:25.620809Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:30:25.02712Z","time spent":"593.516905ms","remote":"127.0.0.1:44856","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:482 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-05-21T03:30:25.628963Z","caller":"traceutil/trace.go:171","msg":"trace[1651358790] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"260.456833ms","start":"2026-05-21T03:30:25.368479Z","end":"2026-05-21T03:30:25.628936Z","steps":["trace[1651358790] 'process raft request'  (duration: 260.290269ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:30:25.629083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.339275ms","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-21T03:30:25.629162Z","caller":"traceutil/trace.go:171","msg":"trace[209456986] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:523; }","duration":"299.473139ms","start":"2026-05-21T03:30:25.329676Z","end":"2026-05-21T03:30:25.629149Z","steps":["trace[209456986] 'agreement among raft nodes before linearized reading'  (duration: 299.311675ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:30:25.62923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.440263ms","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-21T03:30:25.629266Z","caller":"traceutil/trace.go:171","msg":"trace[705792693] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:0; response_revision:523; }","duration":"331.516645ms","start":"2026-05-21T03:30:25.297739Z","end":"2026-05-21T03:30:25.629256Z","steps":["trace[705792693] 'agreement among raft nodes before linearized reading'  (duration: 331.456643ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:30:25.629287Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:30:25.297719Z","time spent":"331.561816ms","remote":"127.0.0.1:44696","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":28,"request content":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" "}
{"level":"info","ts":"2026-05-21T03:30:26.249889Z","caller":"traceutil/trace.go:171","msg":"trace[1368939624] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"395.329618ms","start":"2026-05-21T03:30:25.854514Z","end":"2026-05-21T03:30:26.249844Z","steps":["trace[1368939624] 'process raft request'  (duration: 395.185825ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:30:26.250048Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:30:25.854494Z","time spent":"395.473212ms","remote":"127.0.0.1:44652","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/xmeshes.gateway.networking.x-k8s.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/xmeshes.gateway.networking.x-k8s.io\" value_size:8062 >> failure:<>"}
{"level":"info","ts":"2026-05-21T03:30:26.304239Z","caller":"traceutil/trace.go:171","msg":"trace[2033291181] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"436.683082ms","start":"2026-05-21T03:30:25.867516Z","end":"2026-05-21T03:30:26.304199Z","steps":["trace[2033291181] 'process raft request'  (duration: 436.123389ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T03:30:26.304296Z","caller":"traceutil/trace.go:171","msg":"trace[179426974] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"446.829212ms","start":"2026-05-21T03:30:25.857435Z","end":"2026-05-21T03:30:26.304264Z","steps":["trace[179426974] 'process raft request'  (duration: 446.065142ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T03:30:26.304473Z","caller":"traceutil/trace.go:171","msg":"trace[670932372] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"434.450958ms","start":"2026-05-21T03:30:25.869941Z","end":"2026-05-21T03:30:26.304392Z","steps":["trace[670932372] 'process raft request'  (duration: 433.991957ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T03:30:26.304564Z","caller":"traceutil/trace.go:171","msg":"trace[500472352] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"436.903838ms","start":"2026-05-21T03:30:25.867579Z","end":"2026-05-21T03:30:26.304482Z","steps":["trace[500472352] 'process raft request'  (duration: 436.299933ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:30:26.304647Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:30:25.869934Z","time spent":"434.633882ms","remote":"127.0.0.1:44652","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/xlistenersets.gateway.networking.x-k8s.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/xlistenersets.gateway.networking.x-k8s.io\" value_size:28354 >> failure:<>"}
{"level":"warn","ts":"2026-05-21T03:30:26.304728Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:30:25.867575Z","time spent":"437.038271ms","remote":"127.0.0.1:44652","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/xbackendtrafficpolicies.gateway.networking.x-k8s.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/xbackendtrafficpolicies.gateway.networking.x-k8s.io\" value_size:21901 >> failure:<>"}
{"level":"info","ts":"2026-05-21T03:30:26.304778Z","caller":"traceutil/trace.go:171","msg":"trace[1741083976] linearizableReadLoop","detail":"{readStateIndex:554; appliedIndex:544; }","duration":"368.508762ms","start":"2026-05-21T03:30:25.936191Z","end":"2026-05-21T03:30:26.304699Z","steps":["trace[1741083976] 'read index received'  (duration: 313.530974ms)","trace[1741083976] 'applied index is now lower than readState.Index'  (duration: 54.976518ms)"],"step_count":2}
{"level":"info","ts":"2026-05-21T03:30:26.304955Z","caller":"traceutil/trace.go:171","msg":"trace[2038077822] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"421.228413ms","start":"2026-05-21T03:30:25.883719Z","end":"2026-05-21T03:30:26.304947Z","steps":["trace[2038077822] 'process raft request'  (duration: 420.26789ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T03:30:26.304887Z","caller":"traceutil/trace.go:171","msg":"trace[322645363] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"450.225664ms","start":"2026-05-21T03:30:25.854604Z","end":"2026-05-21T03:30:26.30483Z","steps":["trace[322645363] 'process raft request'  (duration: 448.750788ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:30:26.30501Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:30:25.883702Z","time spent":"421.281125ms","remote":"127.0.0.1:44652","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/tlsroutes.gateway.networking.k8s.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/tlsroutes.gateway.networking.k8s.io\" value_size:63787 >> failure:<>"}
{"level":"info","ts":"2026-05-21T03:30:26.305018Z","caller":"traceutil/trace.go:171","msg":"trace[102928471] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"420.385313ms","start":"2026-05-21T03:30:25.884599Z","end":"2026-05-21T03:30:26.304985Z","steps":["trace[102928471] 'process raft request'  (duration: 419.44387ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T03:30:26.305041Z","caller":"traceutil/trace.go:171","msg":"trace[455375802] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"273.025221ms","start":"2026-05-21T03:30:26.032001Z","end":"2026-05-21T03:30:26.305027Z","steps":["trace[455375802] 'process raft request'  (duration: 272.55084ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:30:26.305332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.131487ms","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-21T03:30:26.305377Z","caller":"traceutil/trace.go:171","msg":"trace[432493364] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:536; }","duration":"369.216849ms","start":"2026-05-21T03:30:25.93615Z","end":"2026-05-21T03:30:26.305367Z","steps":["trace[432493364] 'agreement among raft nodes before linearized reading'  (duration: 368.969143ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:30:26.3051Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:30:25.854571Z","time spent":"450.44971ms","remote":"127.0.0.1:44652","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/referencegrants.gateway.networking.k8s.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/referencegrants.gateway.networking.k8s.io\" value_size:6209 >> failure:<>"}
{"level":"warn","ts":"2026-05-21T03:30:26.305407Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:30:25.936132Z","time spent":"369.26875ms","remote":"127.0.0.1:44856","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-05-21T03:30:26.304897Z","caller":"traceutil/trace.go:171","msg":"trace[1909586899] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"392.891019ms","start":"2026-05-21T03:30:25.911994Z","end":"2026-05-21T03:30:26.304885Z","steps":["trace[1909586899] 'process raft request'  (duration: 392.13525ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:30:26.305489Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:30:25.911968Z","time spent":"393.487103ms","remote":"127.0.0.1:44652","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/gateways.gateway.networking.k8s.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/gateways.gateway.networking.k8s.io\" value_size:58170 >> failure:<>"}
{"level":"warn","ts":"2026-05-21T03:30:26.305138Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:30:25.884591Z","time spent":"420.477335ms","remote":"127.0.0.1:44652","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/backendtlspolicies.gateway.networking.k8s.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/backendtlspolicies.gateway.networking.k8s.io\" value_size:28055 >> failure:<>"}
{"level":"info","ts":"2026-05-21T03:30:26.304649Z","caller":"traceutil/trace.go:171","msg":"trace[1114195472] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"436.908307ms","start":"2026-05-21T03:30:25.867547Z","end":"2026-05-21T03:30:26.304456Z","steps":["trace[1114195472] 'process raft request'  (duration: 436.150109ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:30:26.305731Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:30:25.85742Z","time spent":"446.953814ms","remote":"127.0.0.1:44652","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/gatewayclasses.gateway.networking.k8s.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/gatewayclasses.gateway.networking.k8s.io\" value_size:9385 >> failure:<>"}
{"level":"warn","ts":"2026-05-21T03:30:26.304921Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:30:25.867493Z","time spent":"436.829256ms","remote":"127.0.0.1:44652","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/tcproutes.gateway.networking.k8s.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/tcproutes.gateway.networking.k8s.io\" value_size:29718 >> failure:<>"}
{"level":"warn","ts":"2026-05-21T03:30:26.305799Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:30:25.867525Z","time spent":"438.103467ms","remote":"127.0.0.1:44652","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/udproutes.gateway.networking.k8s.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/udproutes.gateway.networking.k8s.io\" value_size:29699 >> failure:<>"}
{"level":"info","ts":"2026-05-21T03:30:26.305032Z","caller":"traceutil/trace.go:171","msg":"trace[1638052613] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"366.41755ms","start":"2026-05-21T03:30:25.938485Z","end":"2026-05-21T03:30:26.304903Z","steps":["trace[1638052613] 'process raft request'  (duration: 365.722273ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:30:26.305921Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:30:25.938456Z","time spent":"367.432245ms","remote":"127.0.0.1:44652","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/grpcroutes.gateway.networking.k8s.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/grpcroutes.gateway.networking.k8s.io\" value_size:79271 >> failure:<>"}
{"level":"warn","ts":"2026-05-21T03:30:26.308422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.415718ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-21T03:30:26.308481Z","caller":"traceutil/trace.go:171","msg":"trace[435131394] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:538; }","duration":"148.739865ms","start":"2026-05-21T03:30:26.159726Z","end":"2026-05-21T03:30:26.308466Z","steps":["trace[435131394] 'agreement among raft nodes before linearized reading'  (duration: 148.399267ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:30:26.665168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.488262ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3415872876959589297 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/backendtlspolicies.gateway.networking.k8s.io\" mod_revision:549 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/backendtlspolicies.gateway.networking.k8s.io\" value_size:29435 >> failure:<request_range:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/backendtlspolicies.gateway.networking.k8s.io\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-21T03:30:26.665329Z","caller":"traceutil/trace.go:171","msg":"trace[258362067] transaction","detail":"{read_only:false; response_revision:568; number_of_response:1; }","duration":"137.719226ms","start":"2026-05-21T03:30:26.52759Z","end":"2026-05-21T03:30:26.66531Z","steps":["trace[258362067] 'process raft request'  (duration: 35.003558ms)","trace[258362067] 'compare'  (duration: 102.313487ms)"],"step_count":2}
{"level":"info","ts":"2026-05-21T03:30:26.715759Z","caller":"traceutil/trace.go:171","msg":"trace[1481197370] transaction","detail":"{read_only:false; response_revision:569; number_of_response:1; }","duration":"180.082954ms","start":"2026-05-21T03:30:26.535657Z","end":"2026-05-21T03:30:26.715739Z","steps":["trace[1481197370] 'process raft request'  (duration: 179.955481ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T03:30:26.73015Z","caller":"traceutil/trace.go:171","msg":"trace[1126249706] transaction","detail":"{read_only:false; response_revision:570; number_of_response:1; }","duration":"150.445198ms","start":"2026-05-21T03:30:26.579694Z","end":"2026-05-21T03:30:26.730139Z","steps":["trace[1126249706] 'process raft request'  (duration: 150.049458ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T03:30:32.602701Z","caller":"traceutil/trace.go:171","msg":"trace[1929867294] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"235.188854ms","start":"2026-05-21T03:30:32.36747Z","end":"2026-05-21T03:30:32.602659Z","steps":["trace[1929867294] 'process raft request'  (duration: 234.960658ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T03:30:32.681642Z","caller":"traceutil/trace.go:171","msg":"trace[150980007] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"310.816481ms","start":"2026-05-21T03:30:32.37076Z","end":"2026-05-21T03:30:32.681576Z","steps":["trace[150980007] 'process raft request'  (duration: 310.494733ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:30:32.681965Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:30:32.370736Z","time spent":"311.084397ms","remote":"127.0.0.1:44856","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:614 > 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-21T03:30:32.68352Z","caller":"traceutil/trace.go:171","msg":"trace[2013105324] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"284.198219ms","start":"2026-05-21T03:30:32.399293Z","end":"2026-05-21T03:30:32.683491Z","steps":["trace[2013105324] 'process raft request'  (duration: 283.688247ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:30:33.45973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"491.815871ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-c5ft2\" ","response":"range_response_count:1 size:16965"}
{"level":"info","ts":"2026-05-21T03:30:33.459824Z","caller":"traceutil/trace.go:171","msg":"trace[833975277] range","detail":"{range_begin:/registry/pods/kube-system/cilium-c5ft2; range_end:; response_count:1; response_revision:632; }","duration":"491.955685ms","start":"2026-05-21T03:30:32.967844Z","end":"2026-05-21T03:30:33.4598Z","steps":["trace[833975277] 'range keys from in-memory index tree'  (duration: 491.631747ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:30:33.459865Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:30:32.96782Z","time spent":"492.035707ms","remote":"127.0.0.1:44772","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16988,"request content":"key:\"/registry/pods/kube-system/cilium-c5ft2\" "}
{"level":"warn","ts":"2026-05-21T03:30:33.460107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"431.216621ms","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-21T03:30:33.460137Z","caller":"traceutil/trace.go:171","msg":"trace[2028057651] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:632; }","duration":"431.268993ms","start":"2026-05-21T03:30:33.028858Z","end":"2026-05-21T03:30:33.460127Z","steps":["trace[2028057651] 'range keys from in-memory index tree'  (duration: 431.116519ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:30:33.460163Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:30:33.028844Z","time spent":"431.313213ms","remote":"127.0.0.1:44856","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-05-21T03:30:33.460318Z","caller":"traceutil/trace.go:171","msg":"trace[335644932] linearizableReadLoop","detail":"{readStateIndex:655; appliedIndex:654; }","duration":"262.798889ms","start":"2026-05-21T03:30:33.197497Z","end":"2026-05-21T03:30:33.460296Z","steps":["trace[335644932] 'read index received'  (duration: 246.412648ms)","trace[335644932] 'applied index is now lower than readState.Index'  (duration: 16.385401ms)"],"step_count":2}
{"level":"info","ts":"2026-05-21T03:30:33.46042Z","caller":"traceutil/trace.go:171","msg":"trace[1825831122] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"267.505322ms","start":"2026-05-21T03:30:33.1929Z","end":"2026-05-21T03:30:33.460406Z","steps":["trace[1825831122] 'process raft request'  (duration: 251.249285ms)","trace[1825831122] 'compare'  (duration: 15.514059ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-21T03:30:33.460438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.930101ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.248\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-05-21T03:30:33.460479Z","caller":"traceutil/trace.go:171","msg":"trace[1511501411] range","detail":"{range_begin:/registry/masterleases/199.204.45.248; range_end:; response_count:1; response_revision:633; }","duration":"263.024754ms","start":"2026-05-21T03:30:33.197442Z","end":"2026-05-21T03:30:33.460466Z","steps":["trace[1511501411] 'agreement among raft nodes before linearized reading'  (duration: 262.937932ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:30:34.958784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"669.615783ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3415872876959589495 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:618 > 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-21T03:30:34.959092Z","caller":"traceutil/trace.go:171","msg":"trace[1824937872] linearizableReadLoop","detail":"{readStateIndex:657; appliedIndex:655; }","duration":"1.486058321s","start":"2026-05-21T03:30:33.473018Z","end":"2026-05-21T03:30:34.959076Z","steps":["trace[1824937872] 'read index received'  (duration: 17.020305ms)","trace[1824937872] 'applied index is now lower than readState.Index'  (duration: 1.469037216s)"],"step_count":2}
{"level":"info","ts":"2026-05-21T03:30:34.959131Z","caller":"traceutil/trace.go:171","msg":"trace[1591923173] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"1.480040625s","start":"2026-05-21T03:30:33.479041Z","end":"2026-05-21T03:30:34.959081Z","steps":["trace[1591923173] 'process raft request'  (duration: 1.479933453s)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:30:34.959285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.486258096s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-05-21T03:30:34.959322Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:30:33.47902Z","time spent":"1.480197069s","remote":"127.0.0.1:44772","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-c5ft2\" mod_revision:515 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-c5ft2\" value_size:17085 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-c5ft2\" > >"}
{"level":"info","ts":"2026-05-21T03:30:34.959354Z","caller":"traceutil/trace.go:171","msg":"trace[1494610878] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:636; }","duration":"1.486353988s","start":"2026-05-21T03:30:33.472982Z","end":"2026-05-21T03:30:34.959336Z","steps":["trace[1494610878] 'agreement among raft nodes before linearized reading'  (duration: 1.486144253s)"],"step_count":1}
{"level":"info","ts":"2026-05-21T03:30:34.959373Z","caller":"traceutil/trace.go:171","msg":"trace[2112418656] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"1.46634439s","start":"2026-05-21T03:30:33.492986Z","end":"2026-05-21T03:30:34.95933Z","steps":["trace[2112418656] 'process raft request'  (duration: 1.466054253s)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:30:34.959402Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:30:33.472965Z","time spent":"1.48642435s","remote":"127.0.0.1:44610","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-05-21T03:30:34.959445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.363636ms","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-21T03:30:34.959122Z","caller":"traceutil/trace.go:171","msg":"trace[818508293] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"1.491874833s","start":"2026-05-21T03:30:33.467207Z","end":"2026-05-21T03:30:34.959081Z","steps":["trace[818508293] 'process raft request'  (duration: 821.883061ms)","trace[818508293] 'compare'  (duration: 669.458489ms)"],"step_count":2}
{"level":"info","ts":"2026-05-21T03:30:34.959491Z","caller":"traceutil/trace.go:171","msg":"trace[1954384256] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:637; }","duration":"273.409987ms","start":"2026-05-21T03:30:34.686068Z","end":"2026-05-21T03:30:34.959478Z","steps":["trace[1954384256] 'agreement among raft nodes before linearized reading'  (duration: 273.293454ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:30:34.959517Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:30:33.49297Z","time spent":"1.466475433s","remote":"127.0.0.1:44644","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/masterleases/199.204.45.248\" mod_revision:483 > success:<request_put:<key:\"/registry/masterleases/199.204.45.248\" value_size:67 lease:3415872876959589493 >> failure:<request_range:<key:\"/registry/masterleases/199.204.45.248\" > >"}
{"level":"warn","ts":"2026-05-21T03:30:34.959551Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:30:33.467178Z","time spent":"1.492315934s","remote":"127.0.0.1:44856","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:618 > 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":"warn","ts":"2026-05-21T03:30:34.959649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.260427022s","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-21T03:30:34.959575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"801.76965ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-21T03:30:34.959705Z","caller":"traceutil/trace.go:171","msg":"trace[209596257] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:637; }","duration":"1.260469283s","start":"2026-05-21T03:30:33.699216Z","end":"2026-05-21T03:30:34.959686Z","steps":["trace[209596257] 'agreement among raft nodes before linearized reading'  (duration: 1.260378951s)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:30:34.959512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.312037442s","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-21T03:30:34.959743Z","caller":"traceutil/trace.go:171","msg":"trace[1237059812] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"1.434415781s","start":"2026-05-21T03:30:33.525315Z","end":"2026-05-21T03:30:34.959731Z","steps":["trace[1237059812] 'process raft request'  (duration: 1.433909549s)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:30:34.959751Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:30:33.699175Z","time spent":"1.260564405s","remote":"127.0.0.1:44856","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-05-21T03:30:34.959758Z","caller":"traceutil/trace.go:171","msg":"trace[1015027420] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:637; }","duration":"1.312302258s","start":"2026-05-21T03:30:33.647443Z","end":"2026-05-21T03:30:34.959745Z","steps":["trace[1015027420] 'agreement among raft nodes before linearized reading'  (duration: 1.311893238s)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:30:34.959804Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:30:33.64739Z","time spent":"1.31240149s","remote":"127.0.0.1:44856","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-05-21T03:30:34.959807Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:30:33.525299Z","time spent":"1.434478582s","remote":"127.0.0.1:44828","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" mod_revision:0 > success:<request_put:<key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" value_size:2525 >> failure:<>"}
{"level":"info","ts":"2026-05-21T03:30:34.959747Z","caller":"traceutil/trace.go:171","msg":"trace[150518216] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:637; }","duration":"801.931444ms","start":"2026-05-21T03:30:34.1578Z","end":"2026-05-21T03:30:34.959731Z","steps":["trace[150518216] 'agreement among raft nodes before linearized reading'  (duration: 801.75623ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:30:34.959882Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:30:34.157755Z","time spent":"802.120338ms","remote":"127.0.0.1:44616","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-05-21T03:30:36.600919Z","caller":"traceutil/trace.go:171","msg":"trace[1086113198] transaction","detail":"{read_only:false; response_revision:662; number_of_response:1; }","duration":"360.229627ms","start":"2026-05-21T03:30:36.240669Z","end":"2026-05-21T03:30:36.600899Z","steps":["trace[1086113198] 'process raft request'  (duration: 360.113484ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:30:36.601041Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:30:36.240643Z","time spent":"360.3417ms","remote":"127.0.0.1:44652","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3353,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io\" value_size:3262 >> failure:<>"}
{"level":"info","ts":"2026-05-21T03:30:36.605757Z","caller":"traceutil/trace.go:171","msg":"trace[1523460020] transaction","detail":"{read_only:false; response_revision:663; number_of_response:1; }","duration":"162.99158ms","start":"2026-05-21T03:30:36.44274Z","end":"2026-05-21T03:30:36.605732Z","steps":["trace[1523460020] 'process raft request'  (duration: 162.857597ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T03:30:40.308589Z","caller":"traceutil/trace.go:171","msg":"trace[29749162] linearizableReadLoop","detail":"{readStateIndex:744; appliedIndex:743; }","duration":"152.441783ms","start":"2026-05-21T03:30:40.156126Z","end":"2026-05-21T03:30:40.308568Z","steps":["trace[29749162] 'read index received'  (duration: 152.152066ms)","trace[29749162] 'applied index is now lower than readState.Index'  (duration: 289.037µs)"],"step_count":2}
{"level":"info","ts":"2026-05-21T03:30:40.308639Z","caller":"traceutil/trace.go:171","msg":"trace[904094526] transaction","detail":"{read_only:false; response_revision:720; number_of_response:1; }","duration":"162.621031ms","start":"2026-05-21T03:30:40.145988Z","end":"2026-05-21T03:30:40.308609Z","steps":["trace[904094526] 'process raft request'  (duration: 162.364795ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:30:40.308729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.588637ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-21T03:30:40.308775Z","caller":"traceutil/trace.go:171","msg":"trace[534107910] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:720; }","duration":"152.696389ms","start":"2026-05-21T03:30:40.15607Z","end":"2026-05-21T03:30:40.308766Z","steps":["trace[534107910] 'agreement among raft nodes before linearized reading'  (duration: 152.602637ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T03:30:55.348866Z","caller":"traceutil/trace.go:171","msg":"trace[1552271595] transaction","detail":"{read_only:false; response_revision:813; number_of_response:1; }","duration":"283.680859ms","start":"2026-05-21T03:30:55.065159Z","end":"2026-05-21T03:30:55.34884Z","steps":["trace[1552271595] 'process raft request'  (duration: 283.515215ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T03:30:55.516438Z","caller":"traceutil/trace.go:171","msg":"trace[1813679209] transaction","detail":"{read_only:false; response_revision:815; number_of_response:1; }","duration":"422.330174ms","start":"2026-05-21T03:30:55.094079Z","end":"2026-05-21T03:30:55.516409Z","steps":["trace[1813679209] 'process raft request'  (duration: 422.110048ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T03:30:55.516441Z","caller":"traceutil/trace.go:171","msg":"trace[351804497] linearizableReadLoop","detail":"{readStateIndex:843; appliedIndex:841; }","duration":"449.317653ms","start":"2026-05-21T03:30:55.067087Z","end":"2026-05-21T03:30:55.516405Z","steps":["trace[351804497] 'read index received'  (duration: 281.71127ms)","trace[351804497] 'applied index is now lower than readState.Index'  (duration: 167.604373ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-21T03:30:55.516628Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:30:55.094065Z","time spent":"422.447827ms","remote":"127.0.0.1:44828","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" mod_revision:645 > success:<request_put:<key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" value_size:2707 >> failure:<request_range:<key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" > >"}
{"level":"warn","ts":"2026-05-21T03:30:55.516732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"448.794021ms","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-21T03:30:55.516803Z","caller":"traceutil/trace.go:171","msg":"trace[1300876771] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:815; }","duration":"448.921234ms","start":"2026-05-21T03:30:55.067862Z","end":"2026-05-21T03:30:55.516783Z","steps":["trace[1300876771] 'agreement among raft nodes before linearized reading'  (duration: 448.722389ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:30:55.516947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"449.844875ms","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-21T03:30:55.516316Z","caller":"traceutil/trace.go:171","msg":"trace[1004122734] transaction","detail":"{read_only:false; response_revision:814; number_of_response:1; }","duration":"450.485021ms","start":"2026-05-21T03:30:55.065782Z","end":"2026-05-21T03:30:55.516267Z","steps":["trace[1004122734] 'process raft request'  (duration: 450.283496ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T03:30:55.517191Z","caller":"traceutil/trace.go:171","msg":"trace[1708919500] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:815; }","duration":"450.122872ms","start":"2026-05-21T03:30:55.067045Z","end":"2026-05-21T03:30:55.517168Z","steps":["trace[1708919500] 'agreement among raft nodes before linearized reading'  (duration: 449.500147ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:30:55.516973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:30:55.067837Z","time spent":"449.116118ms","remote":"127.0.0.1:44856","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-21T03:30:55.517301Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:30:55.065756Z","time spent":"451.462265ms","remote":"127.0.0.1:44856","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:798 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:367 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-05-21T03:30:55.517621Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:30:55.067032Z","time spent":"450.355829ms","remote":"127.0.0.1:44856","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-21T03:31:30.052178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.418859ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3415872876959590309 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:1020 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-21T03:31:30.052333Z","caller":"traceutil/trace.go:171","msg":"trace[1780052162] linearizableReadLoop","detail":"{readStateIndex:1068; appliedIndex:1066; }","duration":"371.255658ms","start":"2026-05-21T03:31:29.681055Z","end":"2026-05-21T03:31:30.05231Z","steps":["trace[1780052162] 'read index received'  (duration: 70.199845ms)","trace[1780052162] 'applied index is now lower than readState.Index'  (duration: 301.054183ms)"],"step_count":2}
{"level":"info","ts":"2026-05-21T03:31:30.052422Z","caller":"traceutil/trace.go:171","msg":"trace[1972776387] transaction","detail":"{read_only:false; response_revision:1031; number_of_response:1; }","duration":"371.454952ms","start":"2026-05-21T03:31:29.680918Z","end":"2026-05-21T03:31:30.052373Z","steps":["trace[1972776387] 'process raft request'  (duration: 246.703245ms)","trace[1972776387] 'compare'  (duration: 124.273586ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-21T03:31:30.052531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"371.466463ms","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-21T03:31:30.052569Z","caller":"traceutil/trace.go:171","msg":"trace[10869541] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1031; }","duration":"371.515964ms","start":"2026-05-21T03:31:29.68104Z","end":"2026-05-21T03:31:30.052556Z","steps":["trace[10869541] 'agreement among raft nodes before linearized reading'  (duration: 371.327929ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:31:30.052608Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:31:29.681035Z","time spent":"371.564145ms","remote":"127.0.0.1:44856","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-05-21T03:31:30.05264Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:31:29.680903Z","time spent":"371.613016ms","remote":"127.0.0.1:44856","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:1020 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-05-21T03:31:30.2887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.712408ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-21T03:31:30.288833Z","caller":"traceutil/trace.go:171","msg":"trace[1878456838] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1032; }","duration":"129.920003ms","start":"2026-05-21T03:31:30.158887Z","end":"2026-05-21T03:31:30.288807Z","steps":["trace[1878456838] 'range keys from in-memory index tree'  (duration: 129.618475ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:31:52.304875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.380717ms","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-21T03:31:52.305001Z","caller":"traceutil/trace.go:171","msg":"trace[374990531] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:1102; }","duration":"350.577912ms","start":"2026-05-21T03:31:51.9544Z","end":"2026-05-21T03:31:52.304978Z","steps":["trace[374990531] 'count revisions from in-memory index tree'  (duration: 350.268875ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:31:52.305052Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:31:51.954374Z","time spent":"350.665603ms","remote":"127.0.0.1:44774","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":3,"response size":30,"request content":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true "}
{"level":"warn","ts":"2026-05-21T03:31:52.305298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.537864ms","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-21T03:31:52.30535Z","caller":"traceutil/trace.go:171","msg":"trace[1139042290] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1102; }","duration":"154.642417ms","start":"2026-05-21T03:31:52.150695Z","end":"2026-05-21T03:31:52.305338Z","steps":["trace[1139042290] 'range keys from in-memory index tree'  (duration: 154.37589ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:31:52.305395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.273878ms","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-21T03:31:52.30544Z","caller":"traceutil/trace.go:171","msg":"trace[20748752] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1102; }","duration":"154.36369ms","start":"2026-05-21T03:31:52.151063Z","end":"2026-05-21T03:31:52.305427Z","steps":["trace[20748752] 'range keys from in-memory index tree'  (duration: 154.132324ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:31:53.792516Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:31:53.202332Z","time spent":"590.180463ms","remote":"127.0.0.1:44644","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"info","ts":"2026-05-21T03:31:53.792541Z","caller":"traceutil/trace.go:171","msg":"trace[1408607458] linearizableReadLoop","detail":"{readStateIndex:1148; appliedIndex:1148; }","duration":"152.709079ms","start":"2026-05-21T03:31:53.639805Z","end":"2026-05-21T03:31:53.792514Z","steps":["trace[1408607458] 'read index received'  (duration: 152.701959ms)","trace[1408607458] 'applied index is now lower than readState.Index'  (duration: 5.32µs)"],"step_count":2}
{"level":"warn","ts":"2026-05-21T03:31:53.792729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.905364ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-05-21T03:31:53.792804Z","caller":"traceutil/trace.go:171","msg":"trace[887721481] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1106; }","duration":"153.032337ms","start":"2026-05-21T03:31:53.639761Z","end":"2026-05-21T03:31:53.792793Z","steps":["trace[887721481] 'agreement among raft nodes before linearized reading'  (duration: 152.833012ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T03:31:54.126288Z","caller":"traceutil/trace.go:171","msg":"trace[586198515] linearizableReadLoop","detail":"{readStateIndex:1150; appliedIndex:1148; }","duration":"255.773256ms","start":"2026-05-21T03:31:53.870495Z","end":"2026-05-21T03:31:54.126268Z","steps":["trace[586198515] 'read index received'  (duration: 235.317737ms)","trace[586198515] 'applied index is now lower than readState.Index'  (duration: 20.454789ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-21T03:31:54.126472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.981962ms","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-21T03:31:54.126464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.675256ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-21T03:31:54.126511Z","caller":"traceutil/trace.go:171","msg":"trace[978350834] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1108; }","duration":"256.067624ms","start":"2026-05-21T03:31:53.870434Z","end":"2026-05-21T03:31:54.126502Z","steps":["trace[978350834] 'agreement among raft nodes before linearized reading'  (duration: 255.940691ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T03:31:54.126483Z","caller":"traceutil/trace.go:171","msg":"trace[1365132253] transaction","detail":"{read_only:false; response_revision:1107; number_of_response:1; }","duration":"332.438218ms","start":"2026-05-21T03:31:53.794015Z","end":"2026-05-21T03:31:54.126453Z","steps":["trace[1365132253] 'process raft request'  (duration: 311.795605ms)","trace[1365132253] 'compare'  (duration: 19.955207ms)"],"step_count":2}
{"level":"info","ts":"2026-05-21T03:31:54.126537Z","caller":"traceutil/trace.go:171","msg":"trace[1247062469] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:1108; }","duration":"251.767448ms","start":"2026-05-21T03:31:53.874752Z","end":"2026-05-21T03:31:54.12652Z","steps":["trace[1247062469] 'agreement among raft nodes before linearized reading'  (duration: 251.643795ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:31:54.126544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.902842ms","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-21T03:31:54.126624Z","caller":"traceutil/trace.go:171","msg":"trace[988724316] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:1108; }","duration":"136.986304ms","start":"2026-05-21T03:31:53.989626Z","end":"2026-05-21T03:31:54.126613Z","steps":["trace[988724316] 'agreement among raft nodes before linearized reading'  (duration: 136.836991ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T03:31:54.126325Z","caller":"traceutil/trace.go:171","msg":"trace[1192038053] transaction","detail":"{read_only:false; response_revision:1108; number_of_response:1; }","duration":"329.348523ms","start":"2026-05-21T03:31:53.79695Z","end":"2026-05-21T03:31:54.126299Z","steps":["trace[1192038053] 'process raft request'  (duration: 329.261741ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:31:54.126636Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:31:53.793987Z","time spent":"332.562071ms","remote":"127.0.0.1:44644","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/masterleases/199.204.45.248\" mod_revision:1074 > success:<request_put:<key:\"/registry/masterleases/199.204.45.248\" value_size:67 lease:3415872876959590515 >> failure:<request_range:<key:\"/registry/masterleases/199.204.45.248\" > >"}
{"level":"warn","ts":"2026-05-21T03:31:54.126828Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:31:53.796927Z","time spent":"329.802094ms","remote":"127.0.0.1:44856","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:1101 > 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-21T03:31:54.990281Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3415872876959590526,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-05-21T03:31:55.329376Z","caller":"traceutil/trace.go:171","msg":"trace[922132638] transaction","detail":"{read_only:false; response_revision:1111; number_of_response:1; }","duration":"946.768632ms","start":"2026-05-21T03:31:54.382587Z","end":"2026-05-21T03:31:55.329355Z","steps":["trace[922132638] 'process raft request'  (duration: 946.623769ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:31:55.329585Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:31:54.38256Z","time spent":"946.877174ms","remote":"127.0.0.1:44856","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:1105 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:458 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"info","ts":"2026-05-21T03:31:55.538658Z","caller":"traceutil/trace.go:171","msg":"trace[1241990670] linearizableReadLoop","detail":"{readStateIndex:1154; appliedIndex:1152; }","duration":"1.049180192s","start":"2026-05-21T03:31:54.489454Z","end":"2026-05-21T03:31:55.538635Z","steps":["trace[1241990670] 'read index received'  (duration: 839.721408ms)","trace[1241990670] 'applied index is now lower than readState.Index'  (duration: 209.457594ms)"],"step_count":2}
{"level":"info","ts":"2026-05-21T03:31:55.538742Z","caller":"traceutil/trace.go:171","msg":"trace[1839316364] transaction","detail":"{read_only:false; response_revision:1112; number_of_response:1; }","duration":"994.643461ms","start":"2026-05-21T03:31:54.544057Z","end":"2026-05-21T03:31:55.5387Z","steps":["trace[1839316364] 'process raft request'  (duration: 918.4254ms)","trace[1839316364] 'compare'  (duration: 75.896043ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-21T03:31:55.538887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.049407949s","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":"warn","ts":"2026-05-21T03:31:55.538895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:31:54.544047Z","time spent":"994.764725ms","remote":"127.0.0.1:44856","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:1080 > 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-21T03:31:55.538924Z","caller":"traceutil/trace.go:171","msg":"trace[1316734603] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1112; }","duration":"1.049489431s","start":"2026-05-21T03:31:54.489425Z","end":"2026-05-21T03:31:55.538915Z","steps":["trace[1316734603] 'agreement among raft nodes before linearized reading'  (duration: 1.049336247s)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:31:55.538953Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:31:54.489413Z","time spent":"1.049532282s","remote":"127.0.0.1:44856","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-21T03:31:55.538978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"972.381688ms","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-21T03:31:55.539013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"383.069436ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-21T03:31:55.539093Z","caller":"traceutil/trace.go:171","msg":"trace[237310971] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1112; }","duration":"383.156088ms","start":"2026-05-21T03:31:55.15592Z","end":"2026-05-21T03:31:55.539077Z","steps":["trace[237310971] 'agreement among raft nodes before linearized reading'  (duration: 383.039205ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T03:31:55.539044Z","caller":"traceutil/trace.go:171","msg":"trace[830770339] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1112; }","duration":"972.496841ms","start":"2026-05-21T03:31:54.566532Z","end":"2026-05-21T03:31:55.539029Z","steps":["trace[830770339] 'agreement among raft nodes before linearized reading'  (duration: 972.267595ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:31:55.539135Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:31:55.155874Z","time spent":"383.25437ms","remote":"127.0.0.1:44610","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-05-21T03:31:55.539167Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:31:54.566511Z","time spent":"972.646255ms","remote":"127.0.0.1:44856","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-21T03:31:55.539023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"532.522275ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-05-21T03:31:55.539265Z","caller":"traceutil/trace.go:171","msg":"trace[1702296698] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:1112; }","duration":"532.801582ms","start":"2026-05-21T03:31:55.006446Z","end":"2026-05-21T03:31:55.539248Z","steps":["trace[1702296698] 'agreement among raft nodes before linearized reading'  (duration: 532.532016ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:31:55.539339Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:31:55.006425Z","time spent":"532.898395ms","remote":"127.0.0.1:44704","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":5,"response size":30,"request content":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true "}
{"level":"info","ts":"2026-05-21T03:32:14.459998Z","caller":"traceutil/trace.go:171","msg":"trace[1519566173] linearizableReadLoop","detail":"{readStateIndex:1282; appliedIndex:1281; }","duration":"163.110223ms","start":"2026-05-21T03:32:14.296871Z","end":"2026-05-21T03:32:14.459981Z","steps":["trace[1519566173] 'read index received'  (duration: 162.96573ms)","trace[1519566173] 'applied index is now lower than readState.Index'  (duration: 143.973µs)"],"step_count":2}
{"level":"warn","ts":"2026-05-21T03:32:14.460167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.290797ms","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-21T03:32:14.460198Z","caller":"traceutil/trace.go:171","msg":"trace[1396856869] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1234; }","duration":"163.372059ms","start":"2026-05-21T03:32:14.296816Z","end":"2026-05-21T03:32:14.460188Z","steps":["trace[1396856869] 'agreement among raft nodes before linearized reading'  (duration: 163.238186ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T03:32:14.460413Z","caller":"traceutil/trace.go:171","msg":"trace[1979798363] transaction","detail":"{read_only:false; response_revision:1234; number_of_response:1; }","duration":"217.453021ms","start":"2026-05-21T03:32:14.242951Z","end":"2026-05-21T03:32:14.460404Z","steps":["trace[1979798363] 'process raft request'  (duration: 216.934949ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T03:32:14.636359Z","caller":"traceutil/trace.go:171","msg":"trace[446933772] transaction","detail":"{read_only:false; response_revision:1235; number_of_response:1; }","duration":"172.883803ms","start":"2026-05-21T03:32:14.463443Z","end":"2026-05-21T03:32:14.636327Z","steps":["trace[446933772] 'process raft request'  (duration: 147.986675ms)","trace[446933772] 'compare'  (duration: 24.451007ms)"],"step_count":2}
{"level":"info","ts":"2026-05-21T03:32:31.979373Z","caller":"traceutil/trace.go:171","msg":"trace[473009093] linearizableReadLoop","detail":"{readStateIndex:1362; appliedIndex:1361; }","duration":"198.18078ms","start":"2026-05-21T03:32:31.781172Z","end":"2026-05-21T03:32:31.979353Z","steps":["trace[473009093] 'read index received'  (duration: 198.093058ms)","trace[473009093] 'applied index is now lower than readState.Index'  (duration: 86.742µs)"],"step_count":2}
{"level":"info","ts":"2026-05-21T03:32:31.979517Z","caller":"traceutil/trace.go:171","msg":"trace[883676639] transaction","detail":"{read_only:false; response_revision:1311; number_of_response:1; }","duration":"497.409588ms","start":"2026-05-21T03:32:31.482064Z","end":"2026-05-21T03:32:31.979474Z","steps":["trace[883676639] 'process raft request'  (duration: 497.167802ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:32:31.979571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.387196ms","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":"warn","ts":"2026-05-21T03:32:31.979699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.473397ms","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-21T03:32:31.979734Z","caller":"traceutil/trace.go:171","msg":"trace[1669600991] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1311; }","duration":"198.592221ms","start":"2026-05-21T03:32:31.781121Z","end":"2026-05-21T03:32:31.979713Z","steps":["trace[1669600991] 'agreement among raft nodes before linearized reading'  (duration: 198.332744ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:32:31.97974Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:32:31.482038Z","time spent":"497.587012ms","remote":"127.0.0.1:44856","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:1301 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:458 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"info","ts":"2026-05-21T03:32:31.97979Z","caller":"traceutil/trace.go:171","msg":"trace[312945313] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1311; }","duration":"171.58418ms","start":"2026-05-21T03:32:31.808184Z","end":"2026-05-21T03:32:31.979768Z","steps":["trace[312945313] 'agreement among raft nodes before linearized reading'  (duration: 171.301173ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T03:32:32.514616Z","caller":"traceutil/trace.go:171","msg":"trace[1818750523] transaction","detail":"{read_only:false; response_revision:1312; number_of_response:1; }","duration":"530.734542ms","start":"2026-05-21T03:32:31.983841Z","end":"2026-05-21T03:32:32.514576Z","steps":["trace[1818750523] 'process raft request'  (duration: 501.294322ms)","trace[1818750523] 'compare'  (duration: 29.223605ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-21T03:32:32.514829Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:32:31.983817Z","time spent":"530.915117ms","remote":"127.0.0.1:44856","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:1302 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-05-21T03:32:32.514682Z","caller":"traceutil/trace.go:171","msg":"trace[1772527816] transaction","detail":"{read_only:false; response_revision:1313; number_of_response:1; }","duration":"530.781833ms","start":"2026-05-21T03:32:31.983884Z","end":"2026-05-21T03:32:32.514666Z","steps":["trace[1772527816] 'process raft request'  (duration: 530.64281ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:32:32.514922Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:32:31.98386Z","time spent":"531.025229ms","remote":"127.0.0.1:44856","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:1303 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-05-21T03:32:35.0195Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3415872876959590980,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-05-21T03:32:35.092412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.699566287s","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-21T03:32:35.092497Z","caller":"traceutil/trace.go:171","msg":"trace[549233104] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1316; }","duration":"1.6996807s","start":"2026-05-21T03:32:33.392805Z","end":"2026-05-21T03:32:35.092486Z","steps":["trace[549233104] 'range keys from in-memory index tree'  (duration: 1.699551766s)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:32:35.093522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.619084532s","expected-duration":"100ms","prefix":"","request":"header:<ID:3415872876959590983 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/masterleases/199.204.45.248\" mod_revision:1263 > success:<request_put:<key:\"/registry/masterleases/199.204.45.248\" value_size:67 lease:3415872876959590981 >> failure:<request_range:<key:\"/registry/masterleases/199.204.45.248\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-21T03:32:35.093564Z","caller":"traceutil/trace.go:171","msg":"trace[437066681] transaction","detail":"{read_only:false; response_revision:1317; number_of_response:1; }","duration":"1.857184286s","start":"2026-05-21T03:32:33.236372Z","end":"2026-05-21T03:32:35.093557Z","steps":["trace[437066681] 'process raft request'  (duration: 238.024103ms)","trace[437066681] 'compare'  (duration: 1.618301212s)"],"step_count":2}
{"level":"warn","ts":"2026-05-21T03:32:35.093592Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:32:33.236349Z","time spent":"1.857228507s","remote":"127.0.0.1:44644","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/masterleases/199.204.45.248\" mod_revision:1263 > success:<request_put:<key:\"/registry/masterleases/199.204.45.248\" value_size:67 lease:3415872876959590981 >> failure:<request_range:<key:\"/registry/masterleases/199.204.45.248\" > >"}
{"level":"warn","ts":"2026-05-21T03:32:35.186414Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.201195584s","expected-duration":"1s"}
{"level":"info","ts":"2026-05-21T03:32:35.186908Z","caller":"traceutil/trace.go:171","msg":"trace[1146918220] linearizableReadLoop","detail":"{readStateIndex:1370; appliedIndex:1369; }","duration":"667.658116ms","start":"2026-05-21T03:32:34.519219Z","end":"2026-05-21T03:32:35.186878Z","steps":["trace[1146918220] 'read index received'  (duration: 667.362168ms)","trace[1146918220] 'applied index is now lower than readState.Index'  (duration: 294.368µs)"],"step_count":2}
{"level":"info","ts":"2026-05-21T03:32:35.186986Z","caller":"traceutil/trace.go:171","msg":"trace[1149641680] transaction","detail":"{read_only:false; response_revision:1318; number_of_response:1; }","duration":"1.201847521s","start":"2026-05-21T03:32:33.985115Z","end":"2026-05-21T03:32:35.186962Z","steps":["trace[1149641680] 'process raft request'  (duration: 1.201499463s)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:32:35.187105Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:32:33.985089Z","time spent":"1.201935803s","remote":"127.0.0.1:44856","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:1311 > 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-21T03:32:35.187202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"667.965294ms","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-21T03:32:35.18725Z","caller":"traceutil/trace.go:171","msg":"trace[1469272207] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1318; }","duration":"668.065926ms","start":"2026-05-21T03:32:34.519167Z","end":"2026-05-21T03:32:35.187233Z","steps":["trace[1469272207] 'agreement among raft nodes before linearized reading'  (duration: 667.892352ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:32:35.187255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"667.510292ms","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-21T03:32:35.187293Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:32:34.519142Z","time spent":"668.140877ms","remote":"127.0.0.1:44856","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"info","ts":"2026-05-21T03:32:35.187314Z","caller":"traceutil/trace.go:171","msg":"trace[335630262] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1318; }","duration":"667.593915ms","start":"2026-05-21T03:32:34.519705Z","end":"2026-05-21T03:32:35.187299Z","steps":["trace[335630262] 'agreement among raft nodes before linearized reading'  (duration: 667.443481ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:32:35.187351Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:32:34.519694Z","time spent":"667.649136ms","remote":"127.0.0.1:44856","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-05-21T03:32:35.187498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"422.506788ms","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-21T03:32:35.187515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"582.600689ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-05-21T03:32:35.187532Z","caller":"traceutil/trace.go:171","msg":"trace[1339665362] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1318; }","duration":"422.581641ms","start":"2026-05-21T03:32:34.764941Z","end":"2026-05-21T03:32:35.187522Z","steps":["trace[1339665362] 'agreement among raft nodes before linearized reading'  (duration: 422.458468ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T03:32:35.18755Z","caller":"traceutil/trace.go:171","msg":"trace[925299367] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1318; }","duration":"582.655089ms","start":"2026-05-21T03:32:34.604885Z","end":"2026-05-21T03:32:35.18754Z","steps":["trace[925299367] 'agreement among raft nodes before linearized reading'  (duration: 582.555407ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:32:35.187564Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:32:34.764922Z","time spent":"422.630272ms","remote":"127.0.0.1:44856","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-05-21T03:32:35.187581Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:32:34.604844Z","time spent":"582.729831ms","remote":"127.0.0.1:44856","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-05-21T03:32:35.187614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"590.906331ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-05-21T03:32:35.187645Z","caller":"traceutil/trace.go:171","msg":"trace[1016409957] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:1318; }","duration":"590.966823ms","start":"2026-05-21T03:32:34.596669Z","end":"2026-05-21T03:32:35.187636Z","steps":["trace[1016409957] 'agreement among raft nodes before linearized reading'  (duration: 590.84851ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:32:35.187673Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:32:34.596653Z","time spent":"591.013213ms","remote":"127.0.0.1:45072","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":143,"response size":31,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true "}
{"level":"warn","ts":"2026-05-21T03:32:35.187853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"441.771019ms","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-21T03:32:35.187887Z","caller":"traceutil/trace.go:171","msg":"trace[272202503] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1318; }","duration":"441.865631ms","start":"2026-05-21T03:32:34.746011Z","end":"2026-05-21T03:32:35.187877Z","steps":["trace[272202503] 'agreement among raft nodes before linearized reading'  (duration: 441.771889ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:32:35.187927Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:32:34.745984Z","time spent":"441.930642ms","remote":"127.0.0.1:44856","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-05-21T03:32:35.701637Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3415872876959590990,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-05-21T03:32:36.202432Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3415872876959590990,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-05-21T03:32:36.631708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.438068s","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-21T03:32:36.631807Z","caller":"traceutil/trace.go:171","msg":"trace[666346850] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:1318; }","duration":"1.438211884s","start":"2026-05-21T03:32:35.193564Z","end":"2026-05-21T03:32:36.631775Z","steps":["trace[666346850] 'range keys from in-memory index tree'  (duration: 1.437936537s)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:32:36.631848Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:32:35.193549Z","time spent":"1.438289985s","remote":"127.0.0.1:44860","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/endpointslices/default/kubernetes\" "}
{"level":"warn","ts":"2026-05-21T03:32:36.703452Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3415872876959590990,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-05-21T03:32:37.201198Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.007400115s","expected-duration":"1s"}
{"level":"info","ts":"2026-05-21T03:32:37.201588Z","caller":"traceutil/trace.go:171","msg":"trace[1425604778] transaction","detail":"{read_only:false; response_revision:1319; number_of_response:1; }","duration":"2.007893527s","start":"2026-05-21T03:32:35.193678Z","end":"2026-05-21T03:32:37.201571Z","steps":["trace[1425604778] 'process raft request'  (duration: 2.007706553s)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:32:37.201876Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:32:35.193657Z","time spent":"2.007996579s","remote":"127.0.0.1:44856","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:1315 > 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-21T03:32:38.159537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.00032339s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-05-21T03:32:38.159635Z","caller":"traceutil/trace.go:171","msg":"trace[1272159678] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000443063s","start":"2026-05-21T03:32:36.159173Z","end":"2026-05-21T03:32:38.159616Z","steps":["trace[1272159678] 'agreement among raft nodes before linearized reading'  (duration: 2.0003196s)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:32:38.15969Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:32:36.159133Z","time spent":"2.000542815s","remote":"127.0.0.1:44610","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
2026/05/21 03:32:38 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-05-21T03:32:38.528539Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.327152909s","expected-duration":"1s"}
{"level":"info","ts":"2026-05-21T03:32:38.529237Z","caller":"traceutil/trace.go:171","msg":"trace[290976643] transaction","detail":"{read_only:false; response_revision:1320; number_of_response:1; }","duration":"3.335391215s","start":"2026-05-21T03:32:35.193806Z","end":"2026-05-21T03:32:38.529197Z","steps":["trace[290976643] 'process raft request'  (duration: 3.335049137s)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:32:38.529373Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:32:35.193784Z","time spent":"3.335518468s","remote":"127.0.0.1:44856","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:1314 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-05-21T03:32:38.529443Z","caller":"traceutil/trace.go:171","msg":"trace[1016544160] transaction","detail":"{read_only:false; response_revision:1321; number_of_response:1; }","duration":"3.335450286s","start":"2026-05-21T03:32:35.193958Z","end":"2026-05-21T03:32:38.529409Z","steps":["trace[1016544160] 'process raft request'  (duration: 3.33518883s)"],"step_count":1}
{"level":"info","ts":"2026-05-21T03:32:38.529578Z","caller":"traceutil/trace.go:171","msg":"trace[2125390661] transaction","detail":"{read_only:false; response_revision:1322; number_of_response:1; }","duration":"3.335552649s","start":"2026-05-21T03:32:35.193971Z","end":"2026-05-21T03:32:38.529524Z","steps":["trace[2125390661] 'process raft request'  (duration: 3.335369005s)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:32:38.529615Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:32:35.193937Z","time spent":"3.33558856s","remote":"127.0.0.1:44856","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:1313 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-05-21T03:32:38.52971Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:32:35.193957Z","time spent":"3.335703732s","remote":"127.0.0.1:44856","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:1316 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-05-21T03:32:38.529909Z","caller":"traceutil/trace.go:171","msg":"trace[1030993897] linearizableReadLoop","detail":"{readStateIndex:1375; appliedIndex:1370; }","duration":"3.328646829s","start":"2026-05-21T03:32:35.201251Z","end":"2026-05-21T03:32:38.529898Z","steps":["trace[1030993897] 'read index received'  (duration: 2.000230169s)","trace[1030993897] 'applied index is now lower than readState.Index'  (duration: 1.32841582s)"],"step_count":2}
{"level":"info","ts":"2026-05-21T03:32:38.529948Z","caller":"traceutil/trace.go:171","msg":"trace[1860411323] transaction","detail":"{read_only:false; response_revision:1323; number_of_response:1; }","duration":"3.334697367s","start":"2026-05-21T03:32:35.195196Z","end":"2026-05-21T03:32:38.529893Z","steps":["trace[1860411323] 'process raft request'  (duration: 3.334309518s)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:32:38.530376Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:32:35.195182Z","time spent":"3.335167959s","remote":"127.0.0.1:44856","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:1312 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-05-21T03:32:38.530147Z","caller":"traceutil/trace.go:171","msg":"trace[493250202] transaction","detail":"{read_only:false; response_revision:1324; number_of_response:1; }","duration":"1.711105157s","start":"2026-05-21T03:32:36.819031Z","end":"2026-05-21T03:32:38.530137Z","steps":["trace[493250202] 'process raft request'  (duration: 1.710578984s)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:32:38.530203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.328945457s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-21T03:32:38.530917Z","caller":"traceutil/trace.go:171","msg":"trace[1967338030] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:1325; }","duration":"3.329663934s","start":"2026-05-21T03:32:35.20123Z","end":"2026-05-21T03:32:38.530893Z","steps":["trace[1967338030] 'agreement among raft nodes before linearized reading'  (duration: 3.328943107s)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:32:38.530994Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:32:35.201219Z","time spent":"3.329746916s","remote":"127.0.0.1:48728","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true "}
{"level":"info","ts":"2026-05-21T03:32:38.530234Z","caller":"traceutil/trace.go:171","msg":"trace[1195046151] transaction","detail":"{read_only:false; response_revision:1325; number_of_response:1; }","duration":"1.337843011s","start":"2026-05-21T03:32:37.19235Z","end":"2026-05-21T03:32:38.530193Z","steps":["trace[1195046151] 'process raft request'  (duration: 1.337512203s)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:32:38.531172Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:32:37.192331Z","time spent":"1.338798844s","remote":"127.0.0.1:44856","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:1318 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:457 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"warn","ts":"2026-05-21T03:32:38.531505Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:32:36.819007Z","time spent":"1.711814723s","remote":"127.0.0.1:44856","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:1273 > 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-21T03:32:39.458103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"504.778118ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3415872876959590997 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:1280 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-21T03:32:39.458368Z","caller":"traceutil/trace.go:171","msg":"trace[627223744] transaction","detail":"{read_only:false; response_revision:1326; number_of_response:1; }","duration":"1.507669599s","start":"2026-05-21T03:32:37.950674Z","end":"2026-05-21T03:32:39.458344Z","steps":["trace[627223744] 'process raft request'  (duration: 1.002350668s)","trace[627223744] 'compare'  (duration: 504.44819ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-21T03:32:39.458484Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:32:37.950649Z","time spent":"1.507779421s","remote":"127.0.0.1:44856","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:1280 > 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-21T03:32:40.160259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999545801s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-05-21T03:32:40.160329Z","caller":"traceutil/trace.go:171","msg":"trace[826452948] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"1.999664023s","start":"2026-05-21T03:32:38.160651Z","end":"2026-05-21T03:32:40.160315Z","steps":["trace[826452948] 'agreement among raft nodes before linearized reading'  (duration: 1.999569691s)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:32:40.160361Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:32:38.160635Z","time spent":"1.999720735s","remote":"127.0.0.1:44616","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
2026/05/21 03:32:40 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-05-21T03:32:40.334306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"876.072774ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3415872876959590998 > lease_revoke:<id:2f679e48951169d2>","response":"size:28"}
{"level":"info","ts":"2026-05-21T03:32:40.334477Z","caller":"traceutil/trace.go:171","msg":"trace[151317497] transaction","detail":"{read_only:false; response_revision:1327; number_of_response:1; }","duration":"1.286871686s","start":"2026-05-21T03:32:39.047593Z","end":"2026-05-21T03:32:40.334464Z","steps":["trace[151317497] 'process raft request'  (duration: 1.286793835s)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:32:40.334542Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:32:39.047562Z","time spent":"1.286938238s","remote":"127.0.0.1:44680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":889,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/ceph-csi-rbd-provisioner-6f6497f79c-rvn7j.18b1772c177c30a5\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/ceph-csi-rbd-provisioner-6f6497f79c-rvn7j.18b1772c177c30a5\" value_size:784 lease:3415872876959590714 >> failure:<>"}
{"level":"info","ts":"2026-05-21T03:32:40.334685Z","caller":"traceutil/trace.go:171","msg":"trace[135170551] linearizableReadLoop","detail":"{readStateIndex:1379; appliedIndex:1377; }","duration":"1.804381355s","start":"2026-05-21T03:32:38.530295Z","end":"2026-05-21T03:32:40.334677Z","steps":["trace[135170551] 'read index received'  (duration: 422.686342ms)","trace[135170551] 'applied index is now lower than readState.Index'  (duration: 1.381694163s)"],"step_count":2}
{"level":"warn","ts":"2026-05-21T03:32:40.334771Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.076021651s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-21T03:32:40.334789Z","caller":"traceutil/trace.go:171","msg":"trace[27763050] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:1327; }","duration":"4.076080052s","start":"2026-05-21T03:32:36.258702Z","end":"2026-05-21T03:32:40.334782Z","steps":["trace[27763050] 'agreement among raft nodes before linearized reading'  (duration: 4.076026481s)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:32:40.334809Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:32:36.258682Z","time spent":"4.076121404s","remote":"127.0.0.1:48770","response type":"/etcdserverpb.KV/Range","request count":0,"request size":112,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true "}
{"level":"warn","ts":"2026-05-21T03:32:40.33481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.564423364s","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-21T03:32:40.334843Z","caller":"traceutil/trace.go:171","msg":"trace[1621497051] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:1327; }","duration":"1.564504946s","start":"2026-05-21T03:32:38.770329Z","end":"2026-05-21T03:32:40.334834Z","steps":["trace[1621497051] 'agreement among raft nodes before linearized reading'  (duration: 1.564436365s)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:32:40.334866Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:32:38.770279Z","time spent":"1.564581368s","remote":"127.0.0.1:55438","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true "}
{"level":"warn","ts":"2026-05-21T03:32:40.334976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.032919ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-21T03:32:40.335Z","caller":"traceutil/trace.go:171","msg":"trace[595018346] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1327; }","duration":"169.082029ms","start":"2026-05-21T03:32:40.165911Z","end":"2026-05-21T03:32:40.334993Z","steps":["trace[595018346] 'agreement among raft nodes before linearized reading'  (duration: 169.048938ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:32:40.335108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"794.882831ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-05-21T03:32:40.335136Z","caller":"traceutil/trace.go:171","msg":"trace[1008212772] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:1327; }","duration":"794.944423ms","start":"2026-05-21T03:32:39.540185Z","end":"2026-05-21T03:32:40.335129Z","steps":["trace[1008212772] 'agreement among raft nodes before linearized reading'  (duration: 794.893951ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:32:40.335149Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.129485293s","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-21T03:32:40.335203Z","caller":"traceutil/trace.go:171","msg":"trace[1956019618] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1327; }","duration":"1.129559305s","start":"2026-05-21T03:32:39.205636Z","end":"2026-05-21T03:32:40.335196Z","steps":["trace[1956019618] 'agreement among raft nodes before linearized reading'  (duration: 1.129445002s)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:32:40.335155Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:32:39.540169Z","time spent":"794.980073ms","remote":"127.0.0.1:55620","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":1,"response size":30,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "}
{"level":"warn","ts":"2026-05-21T03:32:40.335221Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:32:39.20562Z","time spent":"1.129595756s","remote":"127.0.0.1:44856","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-05-21T03:32:40.335238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.229327ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"warn","ts":"2026-05-21T03:32:40.335341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"944.883035ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-05-21T03:32:40.335401Z","caller":"traceutil/trace.go:171","msg":"trace[412719844] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:1327; }","duration":"944.978387ms","start":"2026-05-21T03:32:39.390408Z","end":"2026-05-21T03:32:40.335387Z","steps":["trace[412719844] 'agreement among raft nodes before linearized reading'  (duration: 944.847214ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:32:40.335459Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:32:39.39039Z","time spent":"945.053379ms","remote":"127.0.0.1:44778","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":45,"response size":30,"request content":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true "}
{"level":"info","ts":"2026-05-21T03:32:40.335356Z","caller":"traceutil/trace.go:171","msg":"trace[1229343648] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:1327; }","duration":"360.35745ms","start":"2026-05-21T03:32:39.974974Z","end":"2026-05-21T03:32:40.335331Z","steps":["trace[1229343648] 'agreement among raft nodes before linearized reading'  (duration: 360.132405ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:32:40.336307Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:32:39.974928Z","time spent":"361.358735ms","remote":"127.0.0.1:44918","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":17,"response size":30,"request content":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true "}
{"level":"warn","ts":"2026-05-21T03:32:40.336151Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.102404213s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-05-21T03:32:40.336582Z","caller":"traceutil/trace.go:171","msg":"trace[1630480179] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:1327; }","duration":"1.102799621s","start":"2026-05-21T03:32:39.233687Z","end":"2026-05-21T03:32:40.336487Z","steps":["trace[1630480179] 'agreement among raft nodes before linearized reading'  (duration: 1.101386836s)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:32:40.336655Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:32:39.23366Z","time spent":"1.102972286s","remote":"127.0.0.1:44998","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":8,"response size":30,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "}
{"level":"warn","ts":"2026-05-21T03:32:41.034458Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3415872876959591003,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-05-21T03:32:41.535219Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3415872876959591003,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-05-21T03:32:42.03615Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3415872876959591003,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-05-21T03:32:42.230006Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.891043241s","expected-duration":"1s"}
{"level":"warn","ts":"2026-05-21T03:32:42.844997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"614.694069ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3415872876959591004 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/kube-system/kube-apiserver-instance.18b1772c5a0c5d56\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/kube-apiserver-instance.18b1772c5a0c5d56\" value_size:672 lease:3415872876959590714 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-05-21T03:32:42.845088Z","caller":"traceutil/trace.go:171","msg":"trace[198480527] transaction","detail":"{read_only:false; response_revision:1328; number_of_response:1; }","duration":"2.506204772s","start":"2026-05-21T03:32:40.338866Z","end":"2026-05-21T03:32:42.845071Z","steps":["trace[198480527] 'process raft request'  (duration: 1.89137325s)","trace[198480527] 'compare'  (duration: 614.402312ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-21T03:32:42.845129Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:32:40.338845Z","time spent":"2.506266733s","remote":"127.0.0.1:44680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":759,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/kube-apiserver-instance.18b1772c5a0c5d56\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/kube-apiserver-instance.18b1772c5a0c5d56\" value_size:672 lease:3415872876959590714 >> failure:<>"}
{"level":"warn","ts":"2026-05-21T03:32:43.670107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000283211s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-05-21T03:32:43.670172Z","caller":"traceutil/trace.go:171","msg":"trace[1866855273] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000388104s","start":"2026-05-21T03:32:41.669768Z","end":"2026-05-21T03:32:43.670157Z","steps":["trace[1866855273] 'agreement among raft nodes before linearized reading'  (duration: 2.000306202s)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:32:43.670204Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:32:41.669747Z","time spent":"2.000450755s","remote":"127.0.0.1:44610","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
2026/05/21 03:32:43 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-05-21T03:32:44.157827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000441651s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-05-21T03:32:44.157904Z","caller":"traceutil/trace.go:171","msg":"trace[979441444] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000558654s","start":"2026-05-21T03:32:42.157327Z","end":"2026-05-21T03:32:44.157886Z","steps":["trace[979441444] 'agreement among raft nodes before linearized reading'  (duration: 2.000464442s)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:32:44.158182Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:32:42.157311Z","time spent":"2.000852671s","remote":"127.0.0.1:44616","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
2026/05/21 03:32:44 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-05-21T03:32:45.337675Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:32:40.338981Z","time spent":"4.998687855s","remote":"127.0.0.1:44856","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""}
2026/05/21 03:32:45 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-05-21T03:32:45.470311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000367679s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-05-21T03:32:45.470379Z","caller":"traceutil/trace.go:171","msg":"trace[90490870] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000534724s","start":"2026-05-21T03:32:43.46983Z","end":"2026-05-21T03:32:45.470365Z","steps":["trace[90490870] 'agreement among raft nodes before linearized reading'  (duration: 2.000450892s)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:32:45.470411Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:32:43.469808Z","time spent":"2.000597275s","remote":"127.0.0.1:44610","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
2026/05/21 03:32:45 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-05-21T03:32:45.490587Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"3.260424821s","expected-duration":"1s"}
{"level":"warn","ts":"2026-05-21T03:32:45.534665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.999729619s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"","error":"context deadline exceeded"}
{"level":"warn","ts":"2026-05-21T03:32:45.534705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.999798091s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-05-21T03:32:45.534767Z","caller":"traceutil/trace.go:171","msg":"trace[1007015140] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; }","duration":"4.999852522s","start":"2026-05-21T03:32:40.534883Z","end":"2026-05-21T03:32:45.534735Z","steps":["trace[1007015140] 'agreement among raft nodes before linearized reading'  (duration: 4.999735719s)"],"step_count":1}
{"level":"info","ts":"2026-05-21T03:32:45.534804Z","caller":"traceutil/trace.go:171","msg":"trace[1821881752] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; }","duration":"4.999927433s","start":"2026-05-21T03:32:40.534863Z","end":"2026-05-21T03:32:45.53479Z","steps":["trace[1821881752] 'agreement among raft nodes before linearized reading'  (duration: 4.999825451s)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:32:45.534839Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:32:40.534843Z","time spent":"4.999979645s","remote":"127.0.0.1:44856","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
2026/05/21 03:32:45 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-05-21T03:32:45.534884Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:32:40.534872Z","time spent":"4.999943214s","remote":"127.0.0.1:44856","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
2026/05/21 03:32:45 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-05-21T03:32:45.53577Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:32:40.537702Z","time spent":"4.998065279s","remote":"127.0.0.1:44856","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""}
{"level":"warn","ts":"2026-05-21T03:32:45.618858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.226670171s","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-21T03:32:45.61895Z","caller":"traceutil/trace.go:171","msg":"trace[346359475] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1328; }","duration":"2.226773015s","start":"2026-05-21T03:32:43.392163Z","end":"2026-05-21T03:32:45.618936Z","steps":["trace[346359475] 'range keys from in-memory index tree'  (duration: 2.226647001s)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:32:45.618999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.187852ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3415872876959591005 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:1319 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-05-21T03:32:45.619166Z","caller":"traceutil/trace.go:171","msg":"trace[34910634] linearizableReadLoop","detail":"{readStateIndex:1383; appliedIndex:1380; }","duration":"5.085326788s","start":"2026-05-21T03:32:40.533826Z","end":"2026-05-21T03:32:45.619153Z","steps":["trace[34910634] 'read index received'  (duration: 1.696420518s)","trace[34910634] 'applied index is now lower than readState.Index'  (duration: 3.38890553s)"],"step_count":2}
{"level":"warn","ts":"2026-05-21T03:32:45.619302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.084362064s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-05-21T03:32:45.619327Z","caller":"traceutil/trace.go:171","msg":"trace[364354744] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1330; }","duration":"5.084407925s","start":"2026-05-21T03:32:40.534912Z","end":"2026-05-21T03:32:45.61932Z","steps":["trace[364354744] 'agreement among raft nodes before linearized reading'  (duration: 5.084309102s)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:32:45.619348Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:32:40.534904Z","time spent":"5.084438765s","remote":"127.0.0.1:44856","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-05-21T03:32:45.619391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.085553573s","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-21T03:32:45.619421Z","caller":"traceutil/trace.go:171","msg":"trace[245745611] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1330; }","duration":"5.085625665s","start":"2026-05-21T03:32:40.533789Z","end":"2026-05-21T03:32:45.619414Z","steps":["trace[245745611] 'agreement among raft nodes before linearized reading'  (duration: 5.08540919s)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:32:45.619421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.45363063s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-05-21T03:32:45.619446Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:32:40.533759Z","time spent":"5.085681467s","remote":"127.0.0.1:44856","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-05-21T03:32:45.619463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.915532079s","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":"info","ts":"2026-05-21T03:32:45.619474Z","caller":"traceutil/trace.go:171","msg":"trace[1946848690] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1330; }","duration":"1.453725722s","start":"2026-05-21T03:32:44.165734Z","end":"2026-05-21T03:32:45.619459Z","steps":["trace[1946848690] 'agreement among raft nodes before linearized reading'  (duration: 1.45363719s)"],"step_count":1}
{"level":"info","ts":"2026-05-21T03:32:45.619496Z","caller":"traceutil/trace.go:171","msg":"trace[1193735757] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:1330; }","duration":"3.91556941s","start":"2026-05-21T03:32:41.703919Z","end":"2026-05-21T03:32:45.619488Z","steps":["trace[1193735757] 'agreement among raft nodes before linearized reading'  (duration: 3.915493278s)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:32:45.619508Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:32:44.165714Z","time spent":"1.453786673s","remote":"127.0.0.1:44616","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-05-21T03:32:45.619516Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:32:41.703815Z","time spent":"3.915695413s","remote":"127.0.0.1:44700","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":17,"response size":30,"request content":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true "}
{"level":"warn","ts":"2026-05-21T03:32:45.619502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.415577808s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.248\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-05-21T03:32:45.619558Z","caller":"traceutil/trace.go:171","msg":"trace[414300217] range","detail":"{range_begin:/registry/masterleases/199.204.45.248; range_end:; response_count:1; response_revision:1330; }","duration":"2.415666819s","start":"2026-05-21T03:32:43.203876Z","end":"2026-05-21T03:32:45.619543Z","steps":["trace[414300217] 'agreement among raft nodes before linearized reading'  (duration: 2.415518235s)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:32:45.619562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.459289626s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/kube-apiserver-instance.18b1772c5a0c5d56\" ","response":"range_response_count:1 size:774"}
{"level":"info","ts":"2026-05-21T03:32:45.61959Z","caller":"traceutil/trace.go:171","msg":"trace[1684359514] range","detail":"{range_begin:/registry/events/kube-system/kube-apiserver-instance.18b1772c5a0c5d56; range_end:; response_count:1; response_revision:1330; }","duration":"1.459356948s","start":"2026-05-21T03:32:44.160226Z","end":"2026-05-21T03:32:45.619583Z","steps":["trace[1684359514] 'agreement among raft nodes before linearized reading'  (duration: 1.459291166s)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:32:45.619591Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:32:43.20386Z","time spent":"2.415723781s","remote":"127.0.0.1:44644","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.204.45.248\" "}
{"level":"warn","ts":"2026-05-21T03:32:45.619613Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:32:44.1602Z","time spent":"1.4594079s","remote":"127.0.0.1:44680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":797,"request content":"key:\"/registry/events/kube-system/kube-apiserver-instance.18b1772c5a0c5d56\" "}
{"level":"warn","ts":"2026-05-21T03:32:45.619672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"417.079443ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-05-21T03:32:45.61971Z","caller":"traceutil/trace.go:171","msg":"trace[1997906661] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:1330; }","duration":"417.147745ms","start":"2026-05-21T03:32:45.202553Z","end":"2026-05-21T03:32:45.619701Z","steps":["trace[1997906661] 'agreement among raft nodes before linearized reading'  (duration: 417.090833ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:32:45.619738Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:32:45.202528Z","time spent":"417.202235ms","remote":"127.0.0.1:44762","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":5,"response size":30,"request content":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true "}
{"level":"warn","ts":"2026-05-21T03:32:46.123894Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3415872876959591008,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-05-21T03:32:46.530001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.547142ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3415872876959591010 username:\"kube-apiserver-etcd-client\" auth_revision:1 > lease_grant:<ttl:15-second id:2f679e4895116a61>","response":"size:40"}
{"level":"warn","ts":"2026-05-21T03:32:46.530071Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:32:45.621591Z","time spent":"908.47694ms","remote":"127.0.0.1:44644","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"warn","ts":"2026-05-21T03:32:47.627069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000128478s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-05-21T03:32:47.627182Z","caller":"traceutil/trace.go:171","msg":"trace[104036855] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000293261s","start":"2026-05-21T03:32:45.626866Z","end":"2026-05-21T03:32:47.627159Z","steps":["trace[104036855] 'agreement among raft nodes before linearized reading'  (duration: 2.000121177s)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:32:47.627243Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:32:45.626818Z","time spent":"2.000411194s","remote":"127.0.0.1:44610","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-21T03:32:48.575007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.499017823s","expected-duration":"100ms","prefix":"","request":"header:<ID:3415872876959591011 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/kube-system/kube-apiserver-instance.18b1772c5a0c5d56\" mod_revision:1328 > success:<request_put:<key:\"/registry/events/kube-system/kube-apiserver-instance.18b1772c5a0c5d56\" value_size:672 lease:3415872876959590714 >> failure:<request_range:<key:\"/registry/events/kube-system/kube-apiserver-instance.18b1772c5a0c5d56\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-21T03:32:48.57527Z","caller":"traceutil/trace.go:171","msg":"trace[1073895237] transaction","detail":"{read_only:false; response_revision:1334; number_of_response:1; }","duration":"2.044437031s","start":"2026-05-21T03:32:46.530819Z","end":"2026-05-21T03:32:48.575256Z","steps":["trace[1073895237] 'process raft request'  (duration: 2.04440314s)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:32:48.575323Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:32:46.530798Z","time spent":"2.044501192s","remote":"127.0.0.1:44644","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/masterleases/199.204.45.248\" mod_revision:1317 > success:<request_put:<key:\"/registry/masterleases/199.204.45.248\" value_size:67 lease:3415872876959591009 >> failure:<request_range:<key:\"/registry/masterleases/199.204.45.248\" > >"}
{"level":"info","ts":"2026-05-21T03:32:48.575414Z","caller":"traceutil/trace.go:171","msg":"trace[1173036369] transaction","detail":"{read_only:false; response_revision:1332; number_of_response:1; }","duration":"2.952018129s","start":"2026-05-21T03:32:45.623372Z","end":"2026-05-21T03:32:48.57539Z","steps":["trace[1173036369] 'process raft request'  (duration: 2.951745082s)"],"step_count":1}
{"level":"info","ts":"2026-05-21T03:32:48.575421Z","caller":"traceutil/trace.go:171","msg":"trace[2921967] transaction","detail":"{read_only:false; response_revision:1333; number_of_response:1; }","duration":"2.951211769s","start":"2026-05-21T03:32:45.624185Z","end":"2026-05-21T03:32:48.575397Z","steps":["trace[2921967] 'process raft request'  (duration: 2.951003784s)"],"step_count":1}
{"level":"info","ts":"2026-05-21T03:32:48.575456Z","caller":"traceutil/trace.go:171","msg":"trace[1574728348] linearizableReadLoop","detail":"{readStateIndex:1387; appliedIndex:1383; }","duration":"2.952269094s","start":"2026-05-21T03:32:45.623179Z","end":"2026-05-21T03:32:48.575448Z","steps":["trace[1574728348] 'read index received'  (duration: 670.292288ms)","trace[1574728348] 'applied index is now lower than readState.Index'  (duration: 2.281975866s)"],"step_count":2}
{"level":"warn","ts":"2026-05-21T03:32:48.575536Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:32:45.623362Z","time spent":"2.952105591s","remote":"127.0.0.1:44856","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:1320 > 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-21T03:32:48.575546Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:32:45.624179Z","time spent":"2.951293901s","remote":"127.0.0.1:44856","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:1322 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-05-21T03:32:48.575537Z","caller":"traceutil/trace.go:171","msg":"trace[974346000] transaction","detail":"{read_only:false; response_revision:1331; number_of_response:1; }","duration":"2.953850904s","start":"2026-05-21T03:32:45.62166Z","end":"2026-05-21T03:32:48.575511Z","steps":["trace[974346000] 'process raft request'  (duration: 1.454225517s)","trace[974346000] 'compare'  (duration: 1.49850797s)"],"step_count":2}
{"level":"warn","ts":"2026-05-21T03:32:48.575659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.952476949s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:549"}
{"level":"warn","ts":"2026-05-21T03:32:48.575655Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:32:45.621645Z","time spent":"2.953944276s","remote":"127.0.0.1:44680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":759,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/kube-apiserver-instance.18b1772c5a0c5d56\" mod_revision:1328 > success:<request_put:<key:\"/registry/events/kube-system/kube-apiserver-instance.18b1772c5a0c5d56\" value_size:672 lease:3415872876959590714 >> failure:<request_range:<key:\"/registry/events/kube-system/kube-apiserver-instance.18b1772c5a0c5d56\" > >"}
{"level":"info","ts":"2026-05-21T03:32:48.575686Z","caller":"traceutil/trace.go:171","msg":"trace[1156179791] range","detail":"{range_begin:/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:1334; }","duration":"2.952520871s","start":"2026-05-21T03:32:45.623158Z","end":"2026-05-21T03:32:48.575679Z","steps":["trace[1156179791] 'agreement among raft nodes before linearized reading'  (duration: 2.952355887s)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:32:48.575706Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:32:45.623146Z","time spent":"2.952554921s","remote":"127.0.0.1:44856","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":572,"request content":"key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" "}
{"level":"warn","ts":"2026-05-21T03:32:49.205566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.865668097s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-05-21T03:32:49.205656Z","caller":"traceutil/trace.go:171","msg":"trace[2126488137] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; }","duration":"1.86578203s","start":"2026-05-21T03:32:47.339833Z","end":"2026-05-21T03:32:49.205615Z","steps":["trace[2126488137] 'agreement among raft nodes before linearized reading'  (duration: 1.865698828s)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:32:49.205696Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:32:47.339812Z","time spent":"1.865872353s","remote":"127.0.0.1:44856","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
2026/05/21 03:32:49 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-05-21T03:32:49.528441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"752.79379ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3415872876959591015 > lease_revoke:<id:2f679e4895116a45>","response":"size:28"}
{"level":"info","ts":"2026-05-21T03:32:49.528603Z","caller":"traceutil/trace.go:171","msg":"trace[1324042021] linearizableReadLoop","detail":"{readStateIndex:1389; appliedIndex:1388; }","duration":"953.108292ms","start":"2026-05-21T03:32:48.575473Z","end":"2026-05-21T03:32:49.528581Z","steps":["trace[1324042021] 'read index received'  (duration: 200.183058ms)","trace[1324042021] 'applied index is now lower than readState.Index'  (duration: 752.922543ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-21T03:32:49.528849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.770924839s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-21T03:32:49.528882Z","caller":"traceutil/trace.go:171","msg":"trace[293196574] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:1334; }","duration":"1.771018131s","start":"2026-05-21T03:32:47.757852Z","end":"2026-05-21T03:32:49.52887Z","steps":["trace[293196574] 'agreement among raft nodes before linearized reading'  (duration: 1.770921349s)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:32:49.528972Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:32:47.757833Z","time spent":"1.771116133s","remote":"127.0.0.1:44758","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":28,"request content":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true "}
{"level":"warn","ts":"2026-05-21T03:32:49.52925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.901707071s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-21T03:32:49.529274Z","caller":"traceutil/trace.go:171","msg":"trace[15397286] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1335; }","duration":"1.901752624s","start":"2026-05-21T03:32:47.627515Z","end":"2026-05-21T03:32:49.529268Z","steps":["trace[15397286] 'agreement among raft nodes before linearized reading'  (duration: 1.901676172s)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:32:49.52934Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:32:47.627502Z","time spent":"1.901831376s","remote":"127.0.0.1:44616","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-05-21T03:32:49.529619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.993397358s","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-21T03:32:49.529643Z","caller":"traceutil/trace.go:171","msg":"trace[1389462138] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1335; }","duration":"1.99345072s","start":"2026-05-21T03:32:47.536186Z","end":"2026-05-21T03:32:49.529637Z","steps":["trace[1389462138] 'agreement among raft nodes before linearized reading'  (duration: 1.993344017s)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:32:49.52971Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:32:47.536169Z","time spent":"1.993534582s","remote":"127.0.0.1:44856","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-21T03:32:49.52994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.994423004s","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-21T03:32:49.52998Z","caller":"traceutil/trace.go:171","msg":"trace[1555209497] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1335; }","duration":"1.994489406s","start":"2026-05-21T03:32:47.535485Z","end":"2026-05-21T03:32:49.529974Z","steps":["trace[1555209497] 'agreement among raft nodes before linearized reading'  (duration: 1.994412894s)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:32:49.530067Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:32:47.535469Z","time spent":"1.994557077s","remote":"127.0.0.1:44856","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-05-21T03:32:49.530231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.597765111s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-21T03:32:49.530255Z","caller":"traceutil/trace.go:171","msg":"trace[226635129] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:1335; }","duration":"2.597832932s","start":"2026-05-21T03:32:46.932417Z","end":"2026-05-21T03:32:49.53025Z","steps":["trace[226635129] 'agreement among raft nodes before linearized reading'  (duration: 2.597793531s)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:32:49.53044Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:32:46.932392Z","time spent":"2.598001066s","remote":"127.0.0.1:44790","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":28,"request content":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true "}
{"level":"warn","ts":"2026-05-21T03:32:49.530627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.729713942s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-21T03:32:49.53067Z","caller":"traceutil/trace.go:171","msg":"trace[643224449] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:1335; }","duration":"3.729799494s","start":"2026-05-21T03:32:45.800863Z","end":"2026-05-21T03:32:49.530663Z","steps":["trace[643224449] 'agreement among raft nodes before linearized reading'  (duration: 3.729738473s)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:32:49.530748Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:32:45.800843Z","time spent":"3.729894456s","remote":"127.0.0.1:48780","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true "}
{"level":"info","ts":"2026-05-21T03:32:49.531445Z","caller":"traceutil/trace.go:171","msg":"trace[1479760284] transaction","detail":"{read_only:false; response_revision:1335; number_of_response:1; }","duration":"952.575199ms","start":"2026-05-21T03:32:48.578858Z","end":"2026-05-21T03:32:49.531433Z","steps":["trace[1479760284] 'process raft request'  (duration: 949.696909ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:32:49.531586Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:32:48.578839Z","time spent":"952.672781ms","remote":"127.0.0.1:44680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":758,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/kube-apiserver-instance.18b1772d968b8f55\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/kube-apiserver-instance.18b1772d968b8f55\" value_size:671 lease:3415872876959590714 >> failure:<>"}
{"level":"warn","ts":"2026-05-21T03:32:50.070916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.154969ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3415872876959591018 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:1324 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-21T03:32:50.0711Z","caller":"traceutil/trace.go:171","msg":"trace[922737755] transaction","detail":"{read_only:false; response_revision:1339; number_of_response:1; }","duration":"473.188346ms","start":"2026-05-21T03:32:49.597897Z","end":"2026-05-21T03:32:50.071086Z","steps":["trace[922737755] 'process raft request'  (duration: 473.159065ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:32:50.071147Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:32:49.59787Z","time spent":"473.257758ms","remote":"127.0.0.1:44856","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:1326 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"info","ts":"2026-05-21T03:32:50.071305Z","caller":"traceutil/trace.go:171","msg":"trace[105608557] transaction","detail":"{read_only:false; response_revision:1337; number_of_response:1; }","duration":"534.76804ms","start":"2026-05-21T03:32:49.536529Z","end":"2026-05-21T03:32:50.071297Z","steps":["trace[105608557] 'process raft request'  (duration: 534.473993ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:32:50.071341Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:32:49.536518Z","time spent":"534.803201ms","remote":"127.0.0.1:44856","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:1321 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-05-21T03:32:50.071405Z","caller":"traceutil/trace.go:171","msg":"trace[1167847417] transaction","detail":"{read_only:false; response_revision:1336; number_of_response:1; }","duration":"1.240256061s","start":"2026-05-21T03:32:48.831113Z","end":"2026-05-21T03:32:50.071369Z","steps":["trace[1167847417] 'process raft request'  (duration: 1.08858461s)","trace[1167847417] 'compare'  (duration: 151.068357ms)"],"step_count":2}
{"level":"info","ts":"2026-05-21T03:32:50.071441Z","caller":"traceutil/trace.go:171","msg":"trace[937349973] transaction","detail":"{read_only:false; response_revision:1338; number_of_response:1; }","duration":"534.172666ms","start":"2026-05-21T03:32:49.537247Z","end":"2026-05-21T03:32:50.07142Z","steps":["trace[937349973] 'process raft request'  (duration: 533.786636ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:32:50.071516Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:32:48.831094Z","time spent":"1.240361034s","remote":"127.0.0.1:44856","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:1324 > 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-21T03:32:50.071428Z","caller":"traceutil/trace.go:171","msg":"trace[172112500] linearizableReadLoop","detail":"{readStateIndex:1391; appliedIndex:1390; }","duration":"542.59828ms","start":"2026-05-21T03:32:49.528672Z","end":"2026-05-21T03:32:50.07127Z","steps":["trace[172112500] 'read index received'  (duration: 390.99473ms)","trace[172112500] 'applied index is now lower than readState.Index'  (duration: 151.59926ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-21T03:32:50.071552Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:32:49.537221Z","time spent":"534.269858ms","remote":"127.0.0.1:44856","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:1323 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-05-21T03:32:50.071558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"864.540994ms","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-21T03:32:50.071591Z","caller":"traceutil/trace.go:171","msg":"trace[1669171961] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1339; }","duration":"864.595905ms","start":"2026-05-21T03:32:49.206987Z","end":"2026-05-21T03:32:50.071583Z","steps":["trace[1669171961] 'agreement among raft nodes before linearized reading'  (duration: 864.431612ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:32:50.071617Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:32:49.206972Z","time spent":"864.639466ms","remote":"127.0.0.1:44856","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-21T03:32:50.071659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"532.756131ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-21T03:32:50.07168Z","caller":"traceutil/trace.go:171","msg":"trace[2115621570] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1339; }","duration":"532.798732ms","start":"2026-05-21T03:32:49.538876Z","end":"2026-05-21T03:32:50.071675Z","steps":["trace[2115621570] 'agreement among raft nodes before linearized reading'  (duration: 532.763731ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:32:50.071697Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:32:49.53886Z","time spent":"532.833283ms","remote":"127.0.0.1:44610","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-05-21T03:32:50.071688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"536.118093ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" ","response":"range_response_count:1 size:7111"}
{"level":"info","ts":"2026-05-21T03:32:50.071765Z","caller":"traceutil/trace.go:171","msg":"trace[279049862] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-instance; range_end:; response_count:1; response_revision:1339; }","duration":"536.205655ms","start":"2026-05-21T03:32:49.535552Z","end":"2026-05-21T03:32:50.071757Z","steps":["trace[279049862] 'agreement among raft nodes before linearized reading'  (duration: 536.097232ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:32:50.071786Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:32:49.535548Z","time spent":"536.233815ms","remote":"127.0.0.1:44772","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":7134,"request content":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" "}
{"level":"warn","ts":"2026-05-21T03:32:50.071834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"536.364939ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/kube-apiserver-instance.18b1772c5a0c5d56\" ","response":"range_response_count:1 size:774"}
{"level":"info","ts":"2026-05-21T03:32:50.071885Z","caller":"traceutil/trace.go:171","msg":"trace[574527156] range","detail":"{range_begin:/registry/events/kube-system/kube-apiserver-instance.18b1772c5a0c5d56; range_end:; response_count:1; response_revision:1339; }","duration":"536.46641ms","start":"2026-05-21T03:32:49.535404Z","end":"2026-05-21T03:32:50.071871Z","steps":["trace[574527156] 'agreement among raft nodes before linearized reading'  (duration: 536.228455ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:32:50.071934Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:32:49.535389Z","time spent":"536.537683ms","remote":"127.0.0.1:44680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":797,"request content":"key:\"/registry/events/kube-system/kube-apiserver-instance.18b1772c5a0c5d56\" "}
{"level":"warn","ts":"2026-05-21T03:32:50.071978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.49479113s","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-21T03:32:50.072298Z","caller":"traceutil/trace.go:171","msg":"trace[1983668212] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:1339; }","duration":"1.495281192s","start":"2026-05-21T03:32:48.576996Z","end":"2026-05-21T03:32:50.072277Z","steps":["trace[1983668212] 'agreement among raft nodes before linearized reading'  (duration: 1.494542654s)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:32:50.072375Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:32:48.576983Z","time spent":"1.495351303s","remote":"127.0.0.1:44762","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":445,"request content":"key:\"/registry/services/endpoints/default/kubernetes\" "}
{"level":"info","ts":"2026-05-21T03:32:50.31543Z","caller":"traceutil/trace.go:171","msg":"trace[1545241727] transaction","detail":"{read_only:false; response_revision:1340; number_of_response:1; }","duration":"240.59308ms","start":"2026-05-21T03:32:50.074817Z","end":"2026-05-21T03:32:50.31541Z","steps":["trace[1545241727] 'process raft request'  (duration: 240.464527ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T03:32:50.315599Z","caller":"traceutil/trace.go:171","msg":"trace[1185703923] linearizableReadLoop","detail":"{readStateIndex:1395; appliedIndex:1395; }","duration":"240.502608ms","start":"2026-05-21T03:32:50.075062Z","end":"2026-05-21T03:32:50.315565Z","steps":["trace[1185703923] 'read index received'  (duration: 240.492297ms)","trace[1185703923] 'applied index is now lower than readState.Index'  (duration: 7.621µs)"],"step_count":2}
{"level":"warn","ts":"2026-05-21T03:32:50.315729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.646171ms","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-21T03:32:50.315754Z","caller":"traceutil/trace.go:171","msg":"trace[1104444235] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:1340; }","duration":"240.699973ms","start":"2026-05-21T03:32:50.075047Z","end":"2026-05-21T03:32:50.315747Z","steps":["trace[1104444235] 'agreement among raft nodes before linearized reading'  (duration: 240.599111ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:32:50.78733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.954032ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3415872876959591028 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/pods/kube-system/kube-apiserver-instance\" mod_revision:413 > success:<request_put:<key:\"/registry/pods/kube-system/kube-apiserver-instance\" value_size:7230 >> failure:<request_range:<key:\"/registry/pods/kube-system/kube-apiserver-instance\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-21T03:32:50.787402Z","caller":"traceutil/trace.go:171","msg":"trace[2019838230] linearizableReadLoop","detail":"{readStateIndex:1396; appliedIndex:1395; }","duration":"469.302392ms","start":"2026-05-21T03:32:50.318088Z","end":"2026-05-21T03:32:50.787391Z","steps":["trace[2019838230] 'read index received'  (duration: 288.143035ms)","trace[2019838230] 'applied index is now lower than readState.Index'  (duration: 181.158577ms)"],"step_count":2}
{"level":"info","ts":"2026-05-21T03:32:50.787537Z","caller":"traceutil/trace.go:171","msg":"trace[2012989656] transaction","detail":"{read_only:false; response_revision:1341; number_of_response:1; }","duration":"707.101885ms","start":"2026-05-21T03:32:50.080427Z","end":"2026-05-21T03:32:50.787529Z","steps":["trace[2012989656] 'process raft request'  (duration: 525.891216ms)","trace[2012989656] 'compare'  (duration: 180.88029ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-21T03:32:50.787576Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:32:50.080403Z","time spent":"707.152356ms","remote":"127.0.0.1:44772","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7288,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/kube-apiserver-instance\" mod_revision:413 > success:<request_put:<key:\"/registry/pods/kube-system/kube-apiserver-instance\" value_size:7230 >> failure:<request_range:<key:\"/registry/pods/kube-system/kube-apiserver-instance\" > >"}
{"level":"warn","ts":"2026-05-21T03:32:50.789622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"471.524056ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/kube-apiserver-instance.18b1772c5a0c5d56\" ","response":"range_response_count:1 size:774"}
{"level":"info","ts":"2026-05-21T03:32:50.789682Z","caller":"traceutil/trace.go:171","msg":"trace[2004321893] range","detail":"{range_begin:/registry/events/kube-system/kube-apiserver-instance.18b1772c5a0c5d56; range_end:; response_count:1; response_revision:1341; }","duration":"471.585858ms","start":"2026-05-21T03:32:50.318064Z","end":"2026-05-21T03:32:50.78965Z","steps":["trace[2004321893] 'agreement among raft nodes before linearized reading'  (duration: 469.567469ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:32:50.789707Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:32:50.318051Z","time spent":"471.650379ms","remote":"127.0.0.1:44680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":797,"request content":"key:\"/registry/events/kube-system/kube-apiserver-instance.18b1772c5a0c5d56\" "}
{"level":"warn","ts":"2026-05-21T03:32:50.794488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.916611ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-05-21T03:32:50.794546Z","caller":"traceutil/trace.go:171","msg":"trace[818253920] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1342; }","duration":"216.053855ms","start":"2026-05-21T03:32:50.578478Z","end":"2026-05-21T03:32:50.794532Z","steps":["trace[818253920] 'agreement among raft nodes before linearized reading'  (duration: 215.895351ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T03:32:50.794824Z","caller":"traceutil/trace.go:171","msg":"trace[1602626399] transaction","detail":"{read_only:false; response_revision:1342; number_of_response:1; }","duration":"214.573738ms","start":"2026-05-21T03:32:50.580242Z","end":"2026-05-21T03:32:50.794816Z","steps":["trace[1602626399] 'process raft request'  (duration: 214.015765ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:32:50.794927Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.588866ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-05-21T03:32:50.794946Z","caller":"traceutil/trace.go:171","msg":"trace[1331323017] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:1342; }","duration":"155.638397ms","start":"2026-05-21T03:32:50.639302Z","end":"2026-05-21T03:32:50.794941Z","steps":["trace[1331323017] 'agreement among raft nodes before linearized reading'  (duration: 155.597816ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:32:50.795169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.082055ms","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-21T03:32:50.795189Z","caller":"traceutil/trace.go:171","msg":"trace[1738403607] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1342; }","duration":"216.103715ms","start":"2026-05-21T03:32:50.579079Z","end":"2026-05-21T03:32:50.795183Z","steps":["trace[1738403607] 'agreement among raft nodes before linearized reading'  (duration: 216.045134ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:32:51.322656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.184947ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3415872876959591034 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:1333 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-21T03:32:51.323019Z","caller":"traceutil/trace.go:171","msg":"trace[842020557] transaction","detail":"{read_only:false; response_revision:1344; number_of_response:1; }","duration":"524.50706ms","start":"2026-05-21T03:32:50.798487Z","end":"2026-05-21T03:32:51.322994Z","steps":["trace[842020557] 'process raft request'  (duration: 347.919674ms)","trace[842020557] 'compare'  (duration: 175.96127ms)"],"step_count":2}
{"level":"info","ts":"2026-05-21T03:32:51.322828Z","caller":"traceutil/trace.go:171","msg":"trace[1939998159] transaction","detail":"{read_only:false; response_revision:1345; number_of_response:1; }","duration":"524.255454ms","start":"2026-05-21T03:32:50.798559Z","end":"2026-05-21T03:32:51.322815Z","steps":["trace[1939998159] 'process raft request'  (duration: 524.170582ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:32:51.323117Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:32:50.798467Z","time spent":"524.597062ms","remote":"127.0.0.1:44856","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:1333 > 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-21T03:32:51.32314Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:32:50.798544Z","time spent":"524.572221ms","remote":"127.0.0.1:44856","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:1332 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-05-21T03:32:51.333064Z","caller":"traceutil/trace.go:171","msg":"trace[1400534299] transaction","detail":"{read_only:false; response_revision:1347; number_of_response:1; }","duration":"518.977584ms","start":"2026-05-21T03:32:50.814064Z","end":"2026-05-21T03:32:51.333041Z","steps":["trace[1400534299] 'process raft request'  (duration: 518.883032ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T03:32:51.333101Z","caller":"traceutil/trace.go:171","msg":"trace[733975494] transaction","detail":"{read_only:false; response_revision:1346; number_of_response:1; }","duration":"521.398464ms","start":"2026-05-21T03:32:50.811673Z","end":"2026-05-21T03:32:51.333072Z","steps":["trace[733975494] 'process raft request'  (duration: 521.149138ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:32:51.333218Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:32:50.811654Z","time spent":"521.503326ms","remote":"127.0.0.1:44680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":785,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/ceph-csi-rbd-provisioner-6f6497f79c-rvn7j.18b1772eb38c26c9\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/ceph-csi-rbd-provisioner-6f6497f79c-rvn7j.18b1772eb38c26c9\" value_size:680 lease:3415872876959590714 >> failure:<>"}
{"level":"warn","ts":"2026-05-21T03:32:51.333246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.448553ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-21T03:32:51.333314Z","caller":"traceutil/trace.go:171","msg":"trace[787970211] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1347; }","duration":"176.525715ms","start":"2026-05-21T03:32:51.156768Z","end":"2026-05-21T03:32:51.333294Z","steps":["trace[787970211] 'agreement among raft nodes before linearized reading'  (duration: 176.399301ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:32:51.334048Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:32:50.814052Z","time spent":"519.087228ms","remote":"127.0.0.1:44772","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7096,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/kube-apiserver-instance\" mod_revision:1341 > success:<request_put:<key:\"/registry/pods/kube-system/kube-apiserver-instance\" value_size:7038 >> failure:<request_range:<key:\"/registry/pods/kube-system/kube-apiserver-instance\" > >"}
{"level":"info","ts":"2026-05-21T03:32:51.334327Z","caller":"traceutil/trace.go:171","msg":"trace[386724957] linearizableReadLoop","detail":"{readStateIndex:1402; appliedIndex:1400; }","duration":"176.219918ms","start":"2026-05-21T03:32:51.156788Z","end":"2026-05-21T03:32:51.333008Z","steps":["trace[386724957] 'read index received'  (duration: 175.982782ms)","trace[386724957] 'applied index is now lower than readState.Index'  (duration: 236.306µs)"],"step_count":2}
{"level":"info","ts":"2026-05-21T03:32:52.606226Z","caller":"traceutil/trace.go:171","msg":"trace[1401313665] transaction","detail":"{read_only:false; response_revision:1384; number_of_response:1; }","duration":"138.866871ms","start":"2026-05-21T03:32:52.467337Z","end":"2026-05-21T03:32:52.606204Z","steps":["trace[1401313665] 'process raft request'  (duration: 53.53796ms)","trace[1401313665] 'compare'  (duration: 85.230249ms)"],"step_count":2}
{"level":"info","ts":"2026-05-21T03:32:52.656014Z","caller":"traceutil/trace.go:171","msg":"trace[276989569] linearizableReadLoop","detail":"{readStateIndex:1440; appliedIndex:1439; }","duration":"106.774222ms","start":"2026-05-21T03:32:52.549221Z","end":"2026-05-21T03:32:52.655995Z","steps":["trace[276989569] 'read index received'  (duration: 106.632188ms)","trace[276989569] 'applied index is now lower than readState.Index'  (duration: 141.444µs)"],"step_count":2}
{"level":"warn","ts":"2026-05-21T03:32:52.65615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.915846ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/extension-apiserver-authentication\" ","response":"range_response_count:1 size:3017"}
{"level":"info","ts":"2026-05-21T03:32:52.656175Z","caller":"traceutil/trace.go:171","msg":"trace[1406741878] range","detail":"{range_begin:/registry/configmaps/kube-system/extension-apiserver-authentication; range_end:; response_count:1; response_revision:1385; }","duration":"106.983457ms","start":"2026-05-21T03:32:52.549183Z","end":"2026-05-21T03:32:52.656167Z","steps":["trace[1406741878] 'agreement among raft nodes before linearized reading'  (duration: 106.886795ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T03:32:52.656487Z","caller":"traceutil/trace.go:171","msg":"trace[798196383] transaction","detail":"{read_only:false; response_revision:1385; number_of_response:1; }","duration":"187.110261ms","start":"2026-05-21T03:32:52.469366Z","end":"2026-05-21T03:32:52.656476Z","steps":["trace[798196383] 'process raft request'  (duration: 186.536517ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T03:33:37.946436Z","caller":"traceutil/trace.go:171","msg":"trace[233606442] linearizableReadLoop","detail":"{readStateIndex:1676; appliedIndex:1675; }","duration":"128.025458ms","start":"2026-05-21T03:33:37.818386Z","end":"2026-05-21T03:33:37.946411Z","steps":["trace[233606442] 'read index received'  (duration: 127.668479ms)","trace[233606442] 'applied index is now lower than readState.Index'  (duration: 355.859µs)"],"step_count":2}
{"level":"info","ts":"2026-05-21T03:33:37.946514Z","caller":"traceutil/trace.go:171","msg":"trace[1440597699] transaction","detail":"{read_only:false; response_revision:1611; number_of_response:1; }","duration":"204.37032ms","start":"2026-05-21T03:33:37.742107Z","end":"2026-05-21T03:33:37.946477Z","steps":["trace[1440597699] 'process raft request'  (duration: 204.089184ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:33:37.946618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.195352ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-21T03:33:37.946715Z","caller":"traceutil/trace.go:171","msg":"trace[1093812409] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:1611; }","duration":"128.315904ms","start":"2026-05-21T03:33:37.818378Z","end":"2026-05-21T03:33:37.946694Z","steps":["trace[1093812409] 'agreement among raft nodes before linearized reading'  (duration: 128.14124ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T03:33:38.41813Z","caller":"traceutil/trace.go:171","msg":"trace[1992902636] transaction","detail":"{read_only:false; response_revision:1616; number_of_response:1; }","duration":"115.703938ms","start":"2026-05-21T03:33:38.302394Z","end":"2026-05-21T03:33:38.418098Z","steps":["trace[1992902636] 'process raft request'  (duration: 115.563205ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T03:33:41.737228Z","caller":"traceutil/trace.go:171","msg":"trace[778057270] transaction","detail":"{read_only:false; response_revision:1629; number_of_response:1; }","duration":"107.779817ms","start":"2026-05-21T03:33:41.629422Z","end":"2026-05-21T03:33:41.737202Z","steps":["trace[778057270] 'process raft request'  (duration: 65.864339ms)","trace[778057270] 'compare'  (duration: 41.792415ms)"],"step_count":2}
{"level":"info","ts":"2026-05-21T03:33:42.607912Z","caller":"traceutil/trace.go:171","msg":"trace[905620273] linearizableReadLoop","detail":"{readStateIndex:1700; appliedIndex:1699; }","duration":"193.756423ms","start":"2026-05-21T03:33:42.414134Z","end":"2026-05-21T03:33:42.607891Z","steps":["trace[905620273] 'read index received'  (duration: 192.318337ms)","trace[905620273] 'applied index is now lower than readState.Index'  (duration: 1.436926ms)"],"step_count":2}
{"level":"info","ts":"2026-05-21T03:33:42.607957Z","caller":"traceutil/trace.go:171","msg":"trace[1729886579] transaction","detail":"{read_only:false; response_revision:1634; number_of_response:1; }","duration":"230.749431ms","start":"2026-05-21T03:33:42.377172Z","end":"2026-05-21T03:33:42.607922Z","steps":["trace[1729886579] 'process raft request'  (duration: 229.246774ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:33:42.608141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.994858ms","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-21T03:33:42.608217Z","caller":"traceutil/trace.go:171","msg":"trace[808903341] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1634; }","duration":"194.112841ms","start":"2026-05-21T03:33:42.414087Z","end":"2026-05-21T03:33:42.6082Z","steps":["trace[808903341] 'agreement among raft nodes before linearized reading'  (duration: 193.895706ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:33:42.608415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.110751ms","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-21T03:33:42.608446Z","caller":"traceutil/trace.go:171","msg":"trace[1373401273] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1634; }","duration":"152.168143ms","start":"2026-05-21T03:33:42.456269Z","end":"2026-05-21T03:33:42.608437Z","steps":["trace[1373401273] 'agreement among raft nodes before linearized reading'  (duration: 152.073701ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:33:42.608546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.614856ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:528"}
{"level":"info","ts":"2026-05-21T03:33:42.608723Z","caller":"traceutil/trace.go:171","msg":"trace[654446232] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1634; }","duration":"171.882322ms","start":"2026-05-21T03:33:42.436776Z","end":"2026-05-21T03:33:42.608658Z","steps":["trace[654446232] 'agreement among raft nodes before linearized reading'  (duration: 171.532524ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T03:33:47.123953Z","caller":"traceutil/trace.go:171","msg":"trace[1313894] transaction","detail":"{read_only:false; response_revision:1657; number_of_response:1; }","duration":"110.38223ms","start":"2026-05-21T03:33:47.013544Z","end":"2026-05-21T03:33:47.123927Z","steps":["trace[1313894] 'process raft request'  (duration: 110.191025ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T03:33:47.925923Z","caller":"traceutil/trace.go:171","msg":"trace[892906537] transaction","detail":"{read_only:false; response_revision:1661; number_of_response:1; }","duration":"113.99154ms","start":"2026-05-21T03:33:47.811903Z","end":"2026-05-21T03:33:47.925895Z","steps":["trace[892906537] 'process raft request'  (duration: 113.802835ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T03:33:51.305446Z","caller":"traceutil/trace.go:171","msg":"trace[1772016094] transaction","detail":"{read_only:false; response_revision:1677; number_of_response:1; }","duration":"133.382167ms","start":"2026-05-21T03:33:51.172039Z","end":"2026-05-21T03:33:51.305421Z","steps":["trace[1772016094] 'process raft request'  (duration: 85.534733ms)","trace[1772016094] 'compare'  (duration: 47.595078ms)"],"step_count":2}
{"level":"info","ts":"2026-05-21T03:33:52.073076Z","caller":"traceutil/trace.go:171","msg":"trace[1187010272] transaction","detail":"{read_only:false; response_revision:1681; number_of_response:1; }","duration":"101.775945ms","start":"2026-05-21T03:33:51.971283Z","end":"2026-05-21T03:33:52.073059Z","steps":["trace[1187010272] 'process raft request'  (duration: 96.479728ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T03:33:52.632461Z","caller":"traceutil/trace.go:171","msg":"trace[288658366] transaction","detail":"{read_only:false; response_revision:1683; number_of_response:1; }","duration":"100.245098ms","start":"2026-05-21T03:33:52.532191Z","end":"2026-05-21T03:33:52.632436Z","steps":["trace[288658366] 'process raft request'  (duration: 100.137226ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T03:33:58.09981Z","caller":"traceutil/trace.go:171","msg":"trace[273338973] transaction","detail":"{read_only:false; response_revision:1711; number_of_response:1; }","duration":"208.90024ms","start":"2026-05-21T03:33:57.890873Z","end":"2026-05-21T03:33:58.099773Z","steps":["trace[273338973] 'process raft request'  (duration: 208.624243ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T03:33:58.221723Z","caller":"traceutil/trace.go:171","msg":"trace[722190059] transaction","detail":"{read_only:false; response_revision:1712; number_of_response:1; }","duration":"115.444914ms","start":"2026-05-21T03:33:58.106242Z","end":"2026-05-21T03:33:58.221687Z","steps":["trace[722190059] 'process raft request'  (duration: 55.193902ms)","trace[722190059] 'compare'  (duration: 59.857863ms)"],"step_count":2}
{"level":"info","ts":"2026-05-21T03:34:02.481235Z","caller":"traceutil/trace.go:171","msg":"trace[2007184978] linearizableReadLoop","detail":"{readStateIndex:1803; appliedIndex:1802; }","duration":"132.756093ms","start":"2026-05-21T03:34:02.348462Z","end":"2026-05-21T03:34:02.481218Z","steps":["trace[2007184978] 'read index received'  (duration: 132.569068ms)","trace[2007184978] 'applied index is now lower than readState.Index'  (duration: 186.275µs)"],"step_count":2}
{"level":"warn","ts":"2026-05-21T03:34:02.481321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.841195ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-21T03:34:02.481343Z","caller":"traceutil/trace.go:171","msg":"trace[543570191] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:1733; }","duration":"132.907327ms","start":"2026-05-21T03:34:02.348427Z","end":"2026-05-21T03:34:02.481334Z","steps":["trace[543570191] 'agreement among raft nodes before linearized reading'  (duration: 132.852495ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T03:34:02.481297Z","caller":"traceutil/trace.go:171","msg":"trace[1648141932] transaction","detail":"{read_only:false; response_revision:1733; number_of_response:1; }","duration":"136.166515ms","start":"2026-05-21T03:34:02.345101Z","end":"2026-05-21T03:34:02.481267Z","steps":["trace[1648141932] 'process raft request'  (duration: 136.006991ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T03:34:02.985127Z","caller":"traceutil/trace.go:171","msg":"trace[862359616] transaction","detail":"{read_only:false; response_revision:1737; number_of_response:1; }","duration":"103.297562ms","start":"2026-05-21T03:34:02.881808Z","end":"2026-05-21T03:34:02.985105Z","steps":["trace[862359616] 'process raft request'  (duration: 22.042232ms)","trace[862359616] 'compare'  (duration: 81.170778ms)"],"step_count":2}
{"level":"info","ts":"2026-05-21T03:34:02.98606Z","caller":"traceutil/trace.go:171","msg":"trace[1304361912] transaction","detail":"{read_only:false; response_revision:1738; number_of_response:1; }","duration":"104.08412ms","start":"2026-05-21T03:34:02.881949Z","end":"2026-05-21T03:34:02.986034Z","steps":["trace[1304361912] 'process raft request'  (duration: 103.891375ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T03:34:05.577668Z","caller":"traceutil/trace.go:171","msg":"trace[1474654369] transaction","detail":"{read_only:false; response_revision:1750; number_of_response:1; }","duration":"130.945068ms","start":"2026-05-21T03:34:05.446684Z","end":"2026-05-21T03:34:05.577629Z","steps":["trace[1474654369] 'process raft request'  (duration: 130.828106ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T03:34:12.547545Z","caller":"traceutil/trace.go:171","msg":"trace[1477239288] transaction","detail":"{read_only:false; response_revision:1783; number_of_response:1; }","duration":"117.831852ms","start":"2026-05-21T03:34:12.429684Z","end":"2026-05-21T03:34:12.547516Z","steps":["trace[1477239288] 'process raft request'  (duration: 117.591966ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:34:13.393927Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.04174ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3415872876959592141 username:\"kube-apiserver-etcd-client\" auth_revision:1 > lease_grant:<ttl:15-second id:2f679e4895116ecc>","response":"size:40"}
{"level":"info","ts":"2026-05-21T03:34:13.39403Z","caller":"traceutil/trace.go:171","msg":"trace[2142936747] linearizableReadLoop","detail":"{readStateIndex:1863; appliedIndex:1862; }","duration":"107.097303ms","start":"2026-05-21T03:34:13.286915Z","end":"2026-05-21T03:34:13.394013Z","steps":["trace[2142936747] 'read index received'  (duration: 40.251µs)","trace[2142936747] 'applied index is now lower than readState.Index'  (duration: 107.055952ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-21T03:34:13.394188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.259217ms","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:509"}
{"level":"info","ts":"2026-05-21T03:34:13.394225Z","caller":"traceutil/trace.go:171","msg":"trace[960299763] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1790; }","duration":"107.351099ms","start":"2026-05-21T03:34:13.286862Z","end":"2026-05-21T03:34:13.394213Z","steps":["trace[960299763] 'agreement among raft nodes before linearized reading'  (duration: 107.196466ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T03:35:19.628611Z","caller":"traceutil/trace.go:171","msg":"trace[1073948342] linearizableReadLoop","detail":"{readStateIndex:2209; appliedIndex:2208; }","duration":"103.241122ms","start":"2026-05-21T03:35:19.525342Z","end":"2026-05-21T03:35:19.628583Z","steps":["trace[1073948342] 'read index received'  (duration: 103.013176ms)","trace[1073948342] 'applied index is now lower than readState.Index'  (duration: 226.996µs)"],"step_count":2}
{"level":"info","ts":"2026-05-21T03:35:19.628704Z","caller":"traceutil/trace.go:171","msg":"trace[2051529935] transaction","detail":"{read_only:false; response_revision:2123; number_of_response:1; }","duration":"120.147533ms","start":"2026-05-21T03:35:19.50851Z","end":"2026-05-21T03:35:19.628658Z","steps":["trace[2051529935] 'process raft request'  (duration: 119.903317ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:35:19.628898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.527468ms","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-21T03:35:19.628961Z","caller":"traceutil/trace.go:171","msg":"trace[232207643] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2123; }","duration":"103.657251ms","start":"2026-05-21T03:35:19.525287Z","end":"2026-05-21T03:35:19.628944Z","steps":["trace[232207643] 'agreement among raft nodes before linearized reading'  (duration: 103.438996ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:35:19.884061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.094036ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3415872876959592972 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:2114 > 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-21T03:35:19.884219Z","caller":"traceutil/trace.go:171","msg":"trace[2119215231] linearizableReadLoop","detail":"{readStateIndex:2211; appliedIndex:2209; }","duration":"163.292231ms","start":"2026-05-21T03:35:19.720911Z","end":"2026-05-21T03:35:19.884203Z","steps":["trace[2119215231] 'read index received'  (duration: 129.795476ms)","trace[2119215231] 'applied index is now lower than readState.Index'  (duration: 33.495885ms)"],"step_count":2}
{"level":"info","ts":"2026-05-21T03:35:19.884284Z","caller":"traceutil/trace.go:171","msg":"trace[1937823022] transaction","detail":"{read_only:false; response_revision:2125; number_of_response:1; }","duration":"250.662297ms","start":"2026-05-21T03:35:19.633608Z","end":"2026-05-21T03:35:19.88427Z","steps":["trace[1937823022] 'process raft request'  (duration: 250.548404ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T03:35:19.884329Z","caller":"traceutil/trace.go:171","msg":"trace[1457184161] transaction","detail":"{read_only:false; response_revision:2124; number_of_response:1; }","duration":"250.757999ms","start":"2026-05-21T03:35:19.633552Z","end":"2026-05-21T03:35:19.88431Z","steps":["trace[1457184161] 'process raft request'  (duration: 85.362496ms)","trace[1457184161] 'compare'  (duration: 164.988113ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-21T03:35:19.884565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.64371ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-21T03:35:19.884607Z","caller":"traceutil/trace.go:171","msg":"trace[1517312507] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:2125; }","duration":"163.738322ms","start":"2026-05-21T03:35:19.720855Z","end":"2026-05-21T03:35:19.884594Z","steps":["trace[1517312507] 'agreement among raft nodes before linearized reading'  (duration: 163.667441ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:35:19.890693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.053394ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:621"}
{"level":"info","ts":"2026-05-21T03:35:19.890741Z","caller":"traceutil/trace.go:171","msg":"trace[1190595591] range","detail":"{range_begin:/registry/configmaps/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:2126; }","duration":"158.136766ms","start":"2026-05-21T03:35:19.732591Z","end":"2026-05-21T03:35:19.890728Z","steps":["trace[1190595591] 'agreement among raft nodes before linearized reading'  (duration: 157.982843ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T03:35:22.03603Z","caller":"traceutil/trace.go:171","msg":"trace[1706284038] transaction","detail":"{read_only:false; response_revision:2133; number_of_response:1; }","duration":"143.264464ms","start":"2026-05-21T03:35:21.892724Z","end":"2026-05-21T03:35:22.035988Z","steps":["trace[1706284038] 'process raft request'  (duration: 104.805849ms)","trace[1706284038] 'compare'  (duration: 38.24097ms)"],"step_count":2}
{"level":"info","ts":"2026-05-21T03:35:22.036051Z","caller":"traceutil/trace.go:171","msg":"trace[1291612774] transaction","detail":"{read_only:false; response_revision:2134; number_of_response:1; }","duration":"141.097632ms","start":"2026-05-21T03:35:21.894924Z","end":"2026-05-21T03:35:22.036022Z","steps":["trace[1291612774] 'process raft request'  (duration: 140.989399ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T03:35:23.504224Z","caller":"traceutil/trace.go:171","msg":"trace[1719746003] transaction","detail":"{read_only:false; response_revision:2142; number_of_response:1; }","duration":"489.454935ms","start":"2026-05-21T03:35:23.014741Z","end":"2026-05-21T03:35:23.504195Z","steps":["trace[1719746003] 'process raft request'  (duration: 489.297601ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:35:23.504377Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:35:23.014717Z","time spent":"489.584858ms","remote":"127.0.0.1:44856","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":512,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" mod_revision:2119 > success:<request_put:<key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" value_size:434 >> failure:<request_range:<key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" > >"}
{"level":"info","ts":"2026-05-21T03:35:23.699754Z","caller":"traceutil/trace.go:171","msg":"trace[1065578042] linearizableReadLoop","detail":"{readStateIndex:2229; appliedIndex:2227; }","duration":"488.058171ms","start":"2026-05-21T03:35:23.211666Z","end":"2026-05-21T03:35:23.699724Z","steps":["trace[1065578042] 'read index received'  (duration: 292.376811ms)","trace[1065578042] 'applied index is now lower than readState.Index'  (duration: 195.68034ms)"],"step_count":2}
{"level":"info","ts":"2026-05-21T03:35:23.699855Z","caller":"traceutil/trace.go:171","msg":"trace[433896838] transaction","detail":"{read_only:false; response_revision:2143; number_of_response:1; }","duration":"611.397712ms","start":"2026-05-21T03:35:23.088408Z","end":"2026-05-21T03:35:23.699806Z","steps":["trace[433896838] 'process raft request'  (duration: 607.316803ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:35:23.700005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"488.320758ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.248\" ","response":"range_response_count:1 size:135"}
{"level":"warn","ts":"2026-05-21T03:35:23.699997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"366.012062ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"warn","ts":"2026-05-21T03:35:23.700043Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:35:23.088383Z","time spent":"611.563735ms","remote":"127.0.0.1:44856","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:2091 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:599 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"info","ts":"2026-05-21T03:35:23.700087Z","caller":"traceutil/trace.go:171","msg":"trace[2110556822] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:2143; }","duration":"366.151076ms","start":"2026-05-21T03:35:23.333917Z","end":"2026-05-21T03:35:23.700068Z","steps":["trace[2110556822] 'agreement among raft nodes before linearized reading'  (duration: 365.993312ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:35:23.700136Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:35:23.333896Z","time spent":"366.229227ms","remote":"127.0.0.1:45070","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":1,"response size":30,"request content":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true "}
{"level":"warn","ts":"2026-05-21T03:35:23.700277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.546014ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-05-21T03:35:23.700267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.730386ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-21T03:35:23.700043Z","caller":"traceutil/trace.go:171","msg":"trace[248097070] range","detail":"{range_begin:/registry/masterleases/199.204.45.248; range_end:; response_count:1; response_revision:2143; }","duration":"488.42174ms","start":"2026-05-21T03:35:23.211611Z","end":"2026-05-21T03:35:23.700032Z","steps":["trace[248097070] 'agreement among raft nodes before linearized reading'  (duration: 488.258506ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T03:35:23.700319Z","caller":"traceutil/trace.go:171","msg":"trace[562822671] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2143; }","duration":"229.621046ms","start":"2026-05-21T03:35:23.470687Z","end":"2026-05-21T03:35:23.700308Z","steps":["trace[562822671] 'agreement among raft nodes before linearized reading'  (duration: 229.546314ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:35:23.700355Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:35:23.211592Z","time spent":"488.753217ms","remote":"127.0.0.1:44644","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.204.45.248\" "}
{"level":"info","ts":"2026-05-21T03:35:23.70033Z","caller":"traceutil/trace.go:171","msg":"trace[1546629104] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:2143; }","duration":"194.844719ms","start":"2026-05-21T03:35:23.505476Z","end":"2026-05-21T03:35:23.70032Z","steps":["trace[1546629104] 'agreement among raft nodes before linearized reading'  (duration: 194.754487ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T03:35:23.891196Z","caller":"traceutil/trace.go:171","msg":"trace[1272386139] transaction","detail":"{read_only:false; response_revision:2146; number_of_response:1; }","duration":"186.266521ms","start":"2026-05-21T03:35:23.704901Z","end":"2026-05-21T03:35:23.891168Z","steps":["trace[1272386139] 'process raft request'  (duration: 186.210239ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T03:35:23.891975Z","caller":"traceutil/trace.go:171","msg":"trace[848680353] transaction","detail":"{read_only:false; response_revision:2145; number_of_response:1; }","duration":"186.477817ms","start":"2026-05-21T03:35:23.704726Z","end":"2026-05-21T03:35:23.891204Z","steps":["trace[848680353] 'process raft request'  (duration: 186.059726ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T03:35:24.254807Z","caller":"traceutil/trace.go:171","msg":"trace[76379820] transaction","detail":"{read_only:false; response_revision:2150; number_of_response:1; }","duration":"149.64627ms","start":"2026-05-21T03:35:24.105123Z","end":"2026-05-21T03:35:24.25477Z","steps":["trace[76379820] 'process raft request'  (duration: 118.201565ms)","trace[76379820] 'compare'  (duration: 31.079976ms)"],"step_count":2}
{"level":"info","ts":"2026-05-21T03:35:26.228604Z","caller":"traceutil/trace.go:171","msg":"trace[1397188478] linearizableReadLoop","detail":"{readStateIndex:2243; appliedIndex:2242; }","duration":"152.501721ms","start":"2026-05-21T03:35:26.076076Z","end":"2026-05-21T03:35:26.228577Z","steps":["trace[1397188478] 'read index received'  (duration: 152.384158ms)","trace[1397188478] 'applied index is now lower than readState.Index'  (duration: 116.573µs)"],"step_count":2}
{"level":"info","ts":"2026-05-21T03:35:26.228671Z","caller":"traceutil/trace.go:171","msg":"trace[1436373797] transaction","detail":"{read_only:false; response_revision:2156; number_of_response:1; }","duration":"170.340954ms","start":"2026-05-21T03:35:26.058292Z","end":"2026-05-21T03:35:26.228633Z","steps":["trace[1436373797] 'process raft request'  (duration: 170.117339ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:35:26.228843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.742326ms","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-21T03:35:26.228898Z","caller":"traceutil/trace.go:171","msg":"trace[475701425] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2156; }","duration":"152.817698ms","start":"2026-05-21T03:35:26.076067Z","end":"2026-05-21T03:35:26.228885Z","steps":["trace[475701425] 'agreement among raft nodes before linearized reading'  (duration: 152.618423ms)"],"step_count":1}
{"level":"info","ts":"2026-05-21T03:35:26.348109Z","caller":"traceutil/trace.go:171","msg":"trace[1322321314] transaction","detail":"{read_only:false; response_revision:2157; number_of_response:1; }","duration":"114.928985ms","start":"2026-05-21T03:35:26.23314Z","end":"2026-05-21T03:35:26.348069Z","steps":["trace[1322321314] 'process raft request'  (duration: 90.05995ms)","trace[1322321314] 'compare'  (duration: 24.643829ms)"],"step_count":2}
{"level":"info","ts":"2026-05-21T03:35:27.456847Z","caller":"traceutil/trace.go:171","msg":"trace[1603248294] transaction","detail":"{read_only:false; response_revision:2162; number_of_response:1; }","duration":"100.633628ms","start":"2026-05-21T03:35:27.356186Z","end":"2026-05-21T03:35:27.456819Z","steps":["trace[1603248294] 'process raft request'  (duration: 100.467204ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:35:28.406778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.067627ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3415872876959593075 > lease_revoke:<id:2f679e48951171b8>","response":"size:28"}
{"level":"info","ts":"2026-05-21T03:35:28.407035Z","caller":"traceutil/trace.go:171","msg":"trace[1660138330] transaction","detail":"{read_only:false; response_revision:2166; number_of_response:1; }","duration":"172.163119ms","start":"2026-05-21T03:35:28.234853Z","end":"2026-05-21T03:35:28.407017Z","steps":["trace[1660138330] 'process raft request'  (duration: 172.019244ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:35:28.466116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.209738ms","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-21T03:35:28.466246Z","caller":"traceutil/trace.go:171","msg":"trace[137100220] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2166; }","duration":"114.413223ms","start":"2026-05-21T03:35:28.351808Z","end":"2026-05-21T03:35:28.466221Z","steps":["trace[137100220] 'agreement among raft nodes before linearized reading'  (duration: 55.186433ms)","trace[137100220] 'range keys from in-memory index tree'  (duration: 58.959674ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-21T03:35:29.08734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.938946ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-05-21T03:35:29.087412Z","caller":"traceutil/trace.go:171","msg":"trace[22114168] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:2171; }","duration":"129.052819ms","start":"2026-05-21T03:35:28.958344Z","end":"2026-05-21T03:35:29.087397Z","steps":["trace[22114168] 'count revisions from in-memory index tree'  (duration: 128.817724ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:35:29.087526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.560868ms","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:510"}
{"level":"info","ts":"2026-05-21T03:35:29.087623Z","caller":"traceutil/trace.go:171","msg":"trace[1875473459] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2171; }","duration":"184.733963ms","start":"2026-05-21T03:35:28.902863Z","end":"2026-05-21T03:35:29.087597Z","steps":["trace[1875473459] 'range keys from in-memory index tree'  (duration: 184.331513ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:36:53.180505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"465.905848ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:536"}
{"level":"info","ts":"2026-05-21T03:36:53.181204Z","caller":"traceutil/trace.go:171","msg":"trace[156644861] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2618; }","duration":"466.237677ms","start":"2026-05-21T03:36:52.714335Z","end":"2026-05-21T03:36:53.180572Z","steps":["trace[156644861] 'range keys from in-memory index tree'  (duration: 465.740674ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:36:53.181224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.679953ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3415872876959594237 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:2609 > 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\" > >>","response":"size:16"}
{"level":"warn","ts":"2026-05-21T03:36:53.181245Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:36:52.714308Z","time spent":"466.926763ms","remote":"127.0.0.1:44856","response type":"/etcdserverpb.KV/Range","request count":0,"request size":75,"response count":1,"response size":559,"request content":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" "}
{"level":"info","ts":"2026-05-21T03:36:53.181351Z","caller":"traceutil/trace.go:171","msg":"trace[1372640906] linearizableReadLoop","detail":"{readStateIndex:2725; appliedIndex:2724; }","duration":"283.353458ms","start":"2026-05-21T03:36:52.897916Z","end":"2026-05-21T03:36:53.181269Z","steps":["trace[1372640906] 'read index received'  (duration: 71.302µs)","trace[1372640906] 'applied index is now lower than readState.Index'  (duration: 283.281246ms)"],"step_count":2}
{"level":"info","ts":"2026-05-21T03:36:53.181415Z","caller":"traceutil/trace.go:171","msg":"trace[1629517181] transaction","detail":"{read_only:false; response_revision:2619; number_of_response:1; }","duration":"423.121415ms","start":"2026-05-21T03:36:52.758286Z","end":"2026-05-21T03:36:53.181408Z","steps":["trace[1629517181] 'process raft request'  (duration: 62.059583ms)","trace[1629517181] 'compare'  (duration: 360.497889ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-21T03:36:53.181452Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T03:36:52.75826Z","time spent":"423.170966ms","remote":"127.0.0.1:44856","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:2609 > 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-21T03:36:53.181488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.017991ms","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-21T03:36:53.181511Z","caller":"traceutil/trace.go:171","msg":"trace[2061350814] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2619; }","duration":"240.078422ms","start":"2026-05-21T03:36:52.941424Z","end":"2026-05-21T03:36:53.181503Z","steps":["trace[2061350814] 'agreement among raft nodes before linearized reading'  (duration: 240.011351ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:36:53.181588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.680275ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-05-21T03:36:53.181608Z","caller":"traceutil/trace.go:171","msg":"trace[365687275] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:2619; }","duration":"283.734117ms","start":"2026-05-21T03:36:52.897868Z","end":"2026-05-21T03:36:53.181602Z","steps":["trace[365687275] 'agreement among raft nodes before linearized reading'  (duration: 283.682426ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-21T03:36:53.181746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.165169ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:478"}
{"level":"info","ts":"2026-05-21T03:36:53.181766Z","caller":"traceutil/trace.go:171","msg":"trace[1969950374] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2619; }","duration":"159.18684ms","start":"2026-05-21T03:36:53.022573Z","end":"2026-05-21T03:36:53.18176Z","steps":["trace[1969950374] 'agreement among raft nodes before linearized reading'  (duration: 159.121998ms)"],"step_count":1}