{"level":"warn","ts":"2026-03-25T07:30:00.423807Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-03-25T07:30:00.423917Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.138: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.138:2380","--initial-cluster=instance=https://199.204.45.138:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.138:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.138:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]}
{"level":"warn","ts":"2026-03-25T07:30:00.423995Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-03-25T07:30:00.424004Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.138:2380"]}
{"level":"info","ts":"2026-03-25T07:30:00.424022Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-03-25T07:30:00.425113Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.138:2379"]}
{"level":"info","ts":"2026-03-25T07:30:00.425304Z","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.138:2380"],"listen-peer-urls":["https://199.204.45.138:2380"],"advertise-client-urls":["https://199.204.45.138:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.138:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.138:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"}
{"level":"info","ts":"2026-03-25T07:30:00.431669Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.072825ms"}
{"level":"info","ts":"2026-03-25T07:30:00.442068Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"f3d52791b64f7591","cluster-id":"90076b89649fe294"}
{"level":"info","ts":"2026-03-25T07:30:00.442227Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 switched to configuration voters=()"}
{"level":"info","ts":"2026-03-25T07:30:00.442275Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 became follower at term 0"}
{"level":"info","ts":"2026-03-25T07:30:00.442323Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft f3d52791b64f7591 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-03-25T07:30:00.442335Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 became follower at term 1"}
{"level":"info","ts":"2026-03-25T07:30:00.442427Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 switched to configuration voters=(17569993028038260113)"}
{"level":"warn","ts":"2026-03-25T07:30:00.45152Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-03-25T07:30:00.45293Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-03-25T07:30:00.457553Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"}
{"level":"info","ts":"2026-03-25T07:30:00.461159Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"f3d52791b64f7591","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-03-25T07:30:00.46141Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"}
{"level":"info","ts":"2026-03-25T07:30:00.461475Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"}
{"level":"info","ts":"2026-03-25T07:30:00.461485Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"}
{"level":"info","ts":"2026-03-25T07:30:00.461568Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"f3d52791b64f7591","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-03-25T07:30:00.465743Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 switched to configuration voters=(17569993028038260113)"}
{"level":"info","ts":"2026-03-25T07:30:00.466027Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"90076b89649fe294","local-member-id":"f3d52791b64f7591","added-peer-id":"f3d52791b64f7591","added-peer-peer-urls":["https://199.204.45.138:2380"]}
{"level":"info","ts":"2026-03-25T07:30:00.470132Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-03-25T07:30:00.47021Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.138:2380"}
{"level":"info","ts":"2026-03-25T07:30:00.470335Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.138:2380"}
{"level":"info","ts":"2026-03-25T07:30:00.470535Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"f3d52791b64f7591","initial-advertise-peer-urls":["https://199.204.45.138:2380"],"listen-peer-urls":["https://199.204.45.138:2380"],"advertise-client-urls":["https://199.204.45.138:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.138:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-03-25T07:30:00.470608Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-03-25T07:30:00.543638Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 is starting a new election at term 1"}
{"level":"info","ts":"2026-03-25T07:30:00.543715Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 became pre-candidate at term 1"}
{"level":"info","ts":"2026-03-25T07:30:00.54375Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 received MsgPreVoteResp from f3d52791b64f7591 at term 1"}
{"level":"info","ts":"2026-03-25T07:30:00.543766Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 became candidate at term 2"}
{"level":"info","ts":"2026-03-25T07:30:00.543773Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 received MsgVoteResp from f3d52791b64f7591 at term 2"}
{"level":"info","ts":"2026-03-25T07:30:00.543784Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 became leader at term 2"}
{"level":"info","ts":"2026-03-25T07:30:00.543793Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: f3d52791b64f7591 elected leader f3d52791b64f7591 at term 2"}
{"level":"info","ts":"2026-03-25T07:30:00.544931Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"f3d52791b64f7591","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.138:2379]}","request-path":"/0/members/f3d52791b64f7591/attributes","cluster-id":"90076b89649fe294","publish-timeout":"7s"}
{"level":"info","ts":"2026-03-25T07:30:00.545037Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-25T07:30:00.545122Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-25T07:30:00.54497Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-25T07:30:00.545239Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-03-25T07:30:00.545642Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-03-25T07:30:00.54638Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"90076b89649fe294","local-member-id":"f3d52791b64f7591","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-25T07:30:00.546619Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-25T07:30:00.546658Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-25T07:30:00.549937Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-03-25T07:30:00.550269Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.138:2379"}
{"level":"info","ts":"2026-03-25T07:30:10.389223Z","caller":"traceutil/trace.go:171","msg":"trace[1585549977] linearizableReadLoop","detail":"{readStateIndex:352; appliedIndex:351; }","duration":"181.625299ms","start":"2026-03-25T07:30:10.207573Z","end":"2026-03-25T07:30:10.389198Z","steps":["trace[1585549977] 'read index received'  (duration: 118.01464ms)","trace[1585549977] 'applied index is now lower than readState.Index'  (duration: 63.609729ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-25T07:30:10.389374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.782552ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"}
{"level":"info","ts":"2026-03-25T07:30:10.389382Z","caller":"traceutil/trace.go:171","msg":"trace[1118939682] transaction","detail":"{read_only:false; response_revision:340; number_of_response:1; }","duration":"211.866358ms","start":"2026-03-25T07:30:10.177448Z","end":"2026-03-25T07:30:10.389315Z","steps":["trace[1118939682] 'process raft request'  (duration: 148.204678ms)","trace[1118939682] 'compare'  (duration: 63.438826ms)"],"step_count":2}
{"level":"info","ts":"2026-03-25T07:30:10.389467Z","caller":"traceutil/trace.go:171","msg":"trace[915792238] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:340; }","duration":"181.952405ms","start":"2026-03-25T07:30:10.207496Z","end":"2026-03-25T07:30:10.389449Z","steps":["trace[915792238] 'agreement among raft nodes before linearized reading'  (duration: 181.811633ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T07:30:16.563647Z","caller":"traceutil/trace.go:171","msg":"trace[834872606] transaction","detail":"{read_only:false; response_revision:411; number_of_response:1; }","duration":"728.209158ms","start":"2026-03-25T07:30:15.835409Z","end":"2026-03-25T07:30:16.563618Z","steps":["trace[834872606] 'process raft request'  (duration: 727.971144ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T07:30:16.564262Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T07:30:15.835387Z","time spent":"728.36321ms","remote":"127.0.0.1:39864","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4649,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/kube-vip-instance\" mod_revision:375 > success:<request_put:<key:\"/registry/pods/kube-system/kube-vip-instance\" value_size:4597 >> failure:<request_range:<key:\"/registry/pods/kube-system/kube-vip-instance\" > >"}
{"level":"warn","ts":"2026-03-25T07:30:17.123067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"464.61974ms","expected-duration":"100ms","prefix":"","request":"header:<ID:8471725151576817046 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:276 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:471 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-25T07:30:17.123146Z","caller":"traceutil/trace.go:171","msg":"trace[422768614] linearizableReadLoop","detail":"{readStateIndex:426; appliedIndex:424; }","duration":"710.727851ms","start":"2026-03-25T07:30:16.412406Z","end":"2026-03-25T07:30:17.123134Z","steps":["trace[422768614] 'read index received'  (duration: 150.923793ms)","trace[422768614] 'applied index is now lower than readState.Index'  (duration: 559.802948ms)"],"step_count":2}
{"level":"info","ts":"2026-03-25T07:30:17.123223Z","caller":"traceutil/trace.go:171","msg":"trace[1562500118] transaction","detail":"{read_only:false; response_revision:412; number_of_response:1; }","duration":"1.058671173s","start":"2026-03-25T07:30:16.064542Z","end":"2026-03-25T07:30:17.123214Z","steps":["trace[1562500118] 'process raft request'  (duration: 593.723497ms)","trace[1562500118] 'compare'  (duration: 464.355125ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-25T07:30:17.12327Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T07:30:16.064524Z","time spent":"1.058722673s","remote":"127.0.0.1:39958","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:276 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:471 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"warn","ts":"2026-03-25T07:30:17.123441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"711.033757ms","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-03-25T07:30:17.123466Z","caller":"traceutil/trace.go:171","msg":"trace[1610332183] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:412; }","duration":"711.118738ms","start":"2026-03-25T07:30:16.412341Z","end":"2026-03-25T07:30:17.12346Z","steps":["trace[1610332183] 'agreement among raft nodes before linearized reading'  (duration: 711.053677ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T07:30:17.123486Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T07:30:16.412327Z","time spent":"711.154118ms","remote":"127.0.0.1:39958","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-03-25T07:30:17.123602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"553.936541ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" ","response":"range_response_count:1 size:6965"}
{"level":"info","ts":"2026-03-25T07:30:17.123678Z","caller":"traceutil/trace.go:171","msg":"trace[1435369157] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-instance; range_end:; response_count:1; response_revision:412; }","duration":"554.085514ms","start":"2026-03-25T07:30:16.569575Z","end":"2026-03-25T07:30:17.123661Z","steps":["trace[1435369157] 'agreement among raft nodes before linearized reading'  (duration: 553.931981ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T07:30:17.123751Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T07:30:16.569553Z","time spent":"554.189385ms","remote":"127.0.0.1:39864","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":6989,"request content":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" "}
{"level":"warn","ts":"2026-03-25T07:30:17.12395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"424.161077ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-03-25T07:30:17.123985Z","caller":"traceutil/trace.go:171","msg":"trace[114201881] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:412; }","duration":"424.246017ms","start":"2026-03-25T07:30:16.69973Z","end":"2026-03-25T07:30:17.123976Z","steps":["trace[114201881] 'agreement among raft nodes before linearized reading'  (duration: 424.190136ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T07:30:17.124011Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T07:30:16.699701Z","time spent":"424.305159ms","remote":"127.0.0.1:39958","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-03-25T07:30:17.125221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.098394ms","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-03-25T07:30:17.125297Z","caller":"traceutil/trace.go:171","msg":"trace[971211541] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:412; }","duration":"107.217818ms","start":"2026-03-25T07:30:17.018061Z","end":"2026-03-25T07:30:17.125279Z","steps":["trace[971211541] 'agreement among raft nodes before linearized reading'  (duration: 107.086584ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T07:30:25.359278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.771593ms","expected-duration":"100ms","prefix":"","request":"header:<ID:8471725151576817140 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:460 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-25T07:30:25.359623Z","caller":"traceutil/trace.go:171","msg":"trace[1374816315] transaction","detail":"{read_only:false; response_revision:464; number_of_response:1; }","duration":"137.162406ms","start":"2026-03-25T07:30:25.222432Z","end":"2026-03-25T07:30:25.359594Z","steps":["trace[1374816315] 'process raft request'  (duration: 19.987066ms)","trace[1374816315] 'compare'  (duration: 116.656861ms)"],"step_count":2}
{"level":"info","ts":"2026-03-25T07:30:25.359744Z","caller":"traceutil/trace.go:171","msg":"trace[1893175302] transaction","detail":"{read_only:false; response_revision:465; number_of_response:1; }","duration":"137.231867ms","start":"2026-03-25T07:30:25.222493Z","end":"2026-03-25T07:30:25.359725Z","steps":["trace[1893175302] 'process raft request'  (duration: 136.887901ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T07:30:25.889329Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8471725151576817142,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-03-25T07:30:26.051192Z","caller":"traceutil/trace.go:171","msg":"trace[2056030244] linearizableReadLoop","detail":"{readStateIndex:482; appliedIndex:481; }","duration":"662.849978ms","start":"2026-03-25T07:30:25.388306Z","end":"2026-03-25T07:30:26.051156Z","steps":["trace[2056030244] 'read index received'  (duration: 661.467733ms)","trace[2056030244] 'applied index is now lower than readState.Index'  (duration: 1.381215ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-25T07:30:26.051345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"663.020741ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-25T07:30:26.051365Z","caller":"traceutil/trace.go:171","msg":"trace[1982811773] transaction","detail":"{read_only:false; response_revision:466; number_of_response:1; }","duration":"688.196218ms","start":"2026-03-25T07:30:25.363137Z","end":"2026-03-25T07:30:26.051333Z","steps":["trace[1982811773] 'process raft request'  (duration: 686.60802ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T07:30:26.0514Z","caller":"traceutil/trace.go:171","msg":"trace[1699611673] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:466; }","duration":"663.135522ms","start":"2026-03-25T07:30:25.388248Z","end":"2026-03-25T07:30:26.051383Z","steps":["trace[1699611673] 'agreement among raft nodes before linearized reading'  (duration: 663.026621ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T07:30:26.051451Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T07:30:25.388208Z","time spent":"663.231224ms","remote":"127.0.0.1:39666","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-03-25T07:30:26.051485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T07:30:25.363114Z","time spent":"688.304499ms","remote":"127.0.0.1:39958","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:461 > 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-03-25T07:30:31.886529Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8471725151576817184,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-25T07:30:32.387178Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8471725151576817184,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-25T07:30:32.887977Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8471725151576817184,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-25T07:30:33.388425Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8471725151576817184,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-25T07:30:33.889139Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8471725151576817184,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-25T07:30:34.387918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999842052s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-03-25T07:30:34.388054Z","caller":"traceutil/trace.go:171","msg":"trace[1771009709] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000044165s","start":"2026-03-25T07:30:32.387985Z","end":"2026-03-25T07:30:34.388029Z","steps":["trace[1771009709] 'agreement among raft nodes before linearized reading'  (duration: 1.999885493s)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T07:30:34.388143Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T07:30:32.387954Z","time spent":"2.000173078s","remote":"127.0.0.1:39666","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-03-25T07:30:34.389279Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8471725151576817184,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-25T07:30:34.890005Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8471725151576817184,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-25T07:30:35.390207Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8471725151576817184,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-25T07:30:35.671651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000529623s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-03-25T07:30:35.671727Z","caller":"traceutil/trace.go:171","msg":"trace[1340026519] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000650544s","start":"2026-03-25T07:30:33.671059Z","end":"2026-03-25T07:30:35.671709Z","steps":["trace[1340026519] 'agreement among raft nodes before linearized reading'  (duration: 2.000547023s)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T07:30:35.671772Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T07:30:33.671042Z","time spent":"2.000721466s","remote":"127.0.0.1:39666","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
2026/03/25 07:30:35 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-03-25T07:30:35.891191Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8471725151576817184,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-25T07:30:36.383648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.997743618s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-03-25T07:30:36.383737Z","caller":"traceutil/trace.go:171","msg":"trace[214124125] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; }","duration":"4.99789658s","start":"2026-03-25T07:30:31.385817Z","end":"2026-03-25T07:30:36.383714Z","steps":["trace[214124125] 'agreement among raft nodes before linearized reading'  (duration: 4.997791018s)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T07:30:36.383801Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T07:30:31.385803Z","time spent":"4.997988471s","remote":"127.0.0.1:39958","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/03/25 07:30:36 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-03-25T07:30:36.389453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000014972s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-03-25T07:30:36.389495Z","caller":"traceutil/trace.go:171","msg":"trace[116712227] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000110254s","start":"2026-03-25T07:30:34.389376Z","end":"2026-03-25T07:30:36.389486Z","steps":["trace[116712227] 'agreement among raft nodes before linearized reading'  (duration: 2.000060143s)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T07:30:36.389523Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T07:30:34.389353Z","time spent":"2.000164574s","remote":"127.0.0.1:39672","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
2026/03/25 07:30:36 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-03-25T07:30:36.39188Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8471725151576817184,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-25T07:30:36.892057Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8471725151576817184,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-25T07:30:37.36624Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"6.110103415s","expected-duration":"1s"}
{"level":"warn","ts":"2026-03-25T07:30:38.03062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.724747454s","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-03-25T07:30:38.030765Z","caller":"traceutil/trace.go:171","msg":"trace[2041075291] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:476; }","duration":"1.724933987s","start":"2026-03-25T07:30:36.30581Z","end":"2026-03-25T07:30:38.030744Z","steps":["trace[2041075291] 'range keys from in-memory index tree'  (duration: 1.724733594s)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T07:30:38.030866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"663.786912ms","expected-duration":"100ms","prefix":"","request":"header:<ID:8471725151576817186 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/secrets/kube-system/sh.helm.release.v1.cilium.v1\" mod_revision:0 > success:<request_put:<key:\"/registry/secrets/kube-system/sh.helm.release.v1.cilium.v1\" value_size:317224 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-03-25T07:30:38.030948Z","caller":"traceutil/trace.go:171","msg":"trace[80756117] transaction","detail":"{read_only:false; response_revision:477; number_of_response:1; }","duration":"6.775800738s","start":"2026-03-25T07:30:31.255133Z","end":"2026-03-25T07:30:38.030933Z","steps":["trace[80756117] 'process raft request'  (duration: 6.111887784s)","trace[80756117] 'compare'  (duration: 662.981679ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-25T07:30:38.031008Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T07:30:31.255104Z","time spent":"6.77588641s","remote":"127.0.0.1:39760","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":317292,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/secrets/kube-system/sh.helm.release.v1.cilium.v1\" mod_revision:0 > success:<request_put:<key:\"/registry/secrets/kube-system/sh.helm.release.v1.cilium.v1\" value_size:317224 >> failure:<>"}
{"level":"warn","ts":"2026-03-25T07:30:38.23826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.999334644s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-03-25T07:30:38.238339Z","caller":"traceutil/trace.go:171","msg":"trace[1476995253] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; }","duration":"4.999467026s","start":"2026-03-25T07:30:33.238853Z","end":"2026-03-25T07:30:38.23832Z","steps":["trace[1476995253] 'agreement among raft nodes before linearized reading'  (duration: 4.999367555s)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T07:30:38.238388Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T07:30:33.238831Z","time spent":"4.999546587s","remote":"127.0.0.1:39958","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/03/25 07:30:38 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-03-25T07:30:38.398158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000178207s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-03-25T07:30:38.398277Z","caller":"traceutil/trace.go:171","msg":"trace[1587101534] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000323889s","start":"2026-03-25T07:30:36.397918Z","end":"2026-03-25T07:30:38.398242Z","steps":["trace[1587101534] 'agreement among raft nodes before linearized reading'  (duration: 2.000205287s)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T07:30:38.39833Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T07:30:36.397875Z","time spent":"2.000443061s","remote":"127.0.0.1:39666","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
2026/03/25 07:30:38 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-03-25T07:30:38.686893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"525.570254ms","expected-duration":"100ms","prefix":"","request":"header:<ID:8471725151576817187 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:457 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-25T07:30:38.687214Z","caller":"traceutil/trace.go:171","msg":"trace[339390056] transaction","detail":"{read_only:false; response_revision:478; number_of_response:1; }","duration":"5.70016358s","start":"2026-03-25T07:30:32.987032Z","end":"2026-03-25T07:30:38.687196Z","steps":["trace[339390056] 'process raft request'  (duration: 5.174174599s)","trace[339390056] 'compare'  (duration: 525.385191ms)"],"step_count":2}
{"level":"info","ts":"2026-03-25T07:30:38.687212Z","caller":"traceutil/trace.go:171","msg":"trace[73005789] transaction","detail":"{read_only:false; response_revision:479; number_of_response:1; }","duration":"3.012307659s","start":"2026-03-25T07:30:35.674884Z","end":"2026-03-25T07:30:38.687192Z","steps":["trace[73005789] 'process raft request'  (duration: 3.012212138s)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T07:30:38.687275Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T07:30:32.987003Z","time spent":"5.700243521s","remote":"127.0.0.1:39958","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:457 > 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-03-25T07:30:38.687283Z","caller":"traceutil/trace.go:171","msg":"trace[856640023] linearizableReadLoop","detail":"{readStateIndex:496; appliedIndex:493; }","duration":"7.301430149s","start":"2026-03-25T07:30:31.385836Z","end":"2026-03-25T07:30:38.687266Z","steps":["trace[856640023] 'read index received'  (duration: 5.980753526s)","trace[856640023] 'applied index is now lower than readState.Index'  (duration: 1.320674563s)"],"step_count":2}
{"level":"warn","ts":"2026-03-25T07:30:38.687303Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T07:30:35.674858Z","time spent":"3.012400981s","remote":"127.0.0.1:39738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":758,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/kube-apiserver-instance.18a00513c63bb28e\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/kube-apiserver-instance.18a00513c63bb28e\" value_size:671 lease:8471725151576816624 >> failure:<>"}
{"level":"warn","ts":"2026-03-25T07:30:38.688063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"7.302222382s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-03-25T07:30:38.688111Z","caller":"traceutil/trace.go:171","msg":"trace[1259069927] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:479; }","duration":"7.302307393s","start":"2026-03-25T07:30:31.385792Z","end":"2026-03-25T07:30:38.688099Z","steps":["trace[1259069927] 'agreement among raft nodes before linearized reading'  (duration: 7.301602082s)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T07:30:38.688132Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T07:30:31.385776Z","time spent":"7.302351074s","remote":"127.0.0.1:39958","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-03-25T07:30:38.688193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"6.616144678s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-03-25T07:30:38.688225Z","caller":"traceutil/trace.go:171","msg":"trace[1913939700] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:480; }","duration":"6.61621285s","start":"2026-03-25T07:30:32.072Z","end":"2026-03-25T07:30:38.688213Z","steps":["trace[1913939700] 'agreement among raft nodes before linearized reading'  (duration: 6.616138518s)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T07:30:38.688216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.401615ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-25T07:30:38.688248Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T07:30:32.071976Z","time spent":"6.61626575s","remote":"127.0.0.1:39958","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-03-25T07:30:38.688259Z","caller":"traceutil/trace.go:171","msg":"trace[1140891467] transaction","detail":"{read_only:false; response_revision:480; number_of_response:1; }","duration":"1.041926174s","start":"2026-03-25T07:30:37.646325Z","end":"2026-03-25T07:30:38.688251Z","steps":["trace[1140891467] 'process raft request'  (duration: 1.041183522s)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T07:30:38.688305Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T07:30:37.646304Z","time spent":"1.041971865s","remote":"127.0.0.1:39958","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:470 > 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-03-25T07:30:38.688317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.676081135s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.138\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-03-25T07:30:38.688314Z","caller":"traceutil/trace.go:171","msg":"trace[1355797562] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:480; }","duration":"289.485946ms","start":"2026-03-25T07:30:38.398771Z","end":"2026-03-25T07:30:38.688257Z","steps":["trace[1355797562] 'agreement among raft nodes before linearized reading'  (duration: 289.378885ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T07:30:38.688306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"633.286213ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-25T07:30:38.688338Z","caller":"traceutil/trace.go:171","msg":"trace[686395458] range","detail":"{range_begin:/registry/masterleases/199.204.45.138; range_end:; response_count:1; response_revision:480; }","duration":"4.676132525s","start":"2026-03-25T07:30:34.012197Z","end":"2026-03-25T07:30:38.688329Z","steps":["trace[686395458] 'agreement among raft nodes before linearized reading'  (duration: 4.676101815s)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T07:30:38.688391Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T07:30:34.012177Z","time spent":"4.676176477s","remote":"127.0.0.1:39692","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":159,"request content":"key:\"/registry/masterleases/199.204.45.138\" "}
{"level":"warn","ts":"2026-03-25T07:30:38.688396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.083155ms","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-03-25T07:30:38.68837Z","caller":"traceutil/trace.go:171","msg":"trace[1430816705] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:480; }","duration":"633.378595ms","start":"2026-03-25T07:30:38.054974Z","end":"2026-03-25T07:30:38.688352Z","steps":["trace[1430816705] 'agreement among raft nodes before linearized reading'  (duration: 633.243033ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T07:30:38.688875Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T07:30:38.054956Z","time spent":"633.816981ms","remote":"127.0.0.1:39748","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":29,"request content":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" "}
{"level":"info","ts":"2026-03-25T07:30:38.689209Z","caller":"traceutil/trace.go:171","msg":"trace[307790472] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:480; }","duration":"303.201116ms","start":"2026-03-25T07:30:38.385252Z","end":"2026-03-25T07:30:38.688453Z","steps":["trace[307790472] 'agreement among raft nodes before linearized reading'  (duration: 303.061464ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T07:30:38.689738Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T07:30:38.385231Z","time spent":"304.358014ms","remote":"127.0.0.1:39958","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-03-25T07:30:39.33064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"375.076891ms","expected-duration":"100ms","prefix":"","request":"header:<ID:8471725151576817194 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/kube-system/kube-apiserver-instance.18a00513f106b69f\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/kube-apiserver-instance.18a00513f106b69f\" value_size:672 lease:8471725151576816624 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-03-25T07:30:39.330838Z","caller":"traceutil/trace.go:171","msg":"trace[235109487] transaction","detail":"{read_only:false; response_revision:481; number_of_response:1; }","duration":"638.543289ms","start":"2026-03-25T07:30:38.692252Z","end":"2026-03-25T07:30:39.330795Z","steps":["trace[235109487] 'process raft request'  (duration: 263.249614ms)","trace[235109487] 'compare'  (duration: 374.645045ms)"],"step_count":2}
{"level":"info","ts":"2026-03-25T07:30:39.330892Z","caller":"traceutil/trace.go:171","msg":"trace[1668981312] linearizableReadLoop","detail":"{readStateIndex:504; appliedIndex:498; }","duration":"634.94818ms","start":"2026-03-25T07:30:38.69593Z","end":"2026-03-25T07:30:39.330879Z","steps":["trace[1668981312] 'read index received'  (duration: 39.678387ms)","trace[1668981312] 'applied index is now lower than readState.Index'  (duration: 595.268983ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-25T07:30:39.330942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"635.001581ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-25T07:30:39.331296Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T07:30:38.692235Z","time spent":"638.987945ms","remote":"127.0.0.1:39738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":759,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/kube-apiserver-instance.18a00513f106b69f\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/kube-apiserver-instance.18a00513f106b69f\" value_size:672 lease:8471725151576816624 >> failure:<>"}
{"level":"info","ts":"2026-03-25T07:30:39.331357Z","caller":"traceutil/trace.go:171","msg":"trace[1833882053] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:486; }","duration":"635.441918ms","start":"2026-03-25T07:30:38.695895Z","end":"2026-03-25T07:30:39.331337Z","steps":["trace[1833882053] 'agreement among raft nodes before linearized reading'  (duration: 635.016862ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T07:30:39.331428Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T07:30:38.695865Z","time spent":"635.539829ms","remote":"127.0.0.1:39666","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-03-25T07:30:39.330974Z","caller":"traceutil/trace.go:171","msg":"trace[1678921688] transaction","detail":"{read_only:false; response_revision:486; number_of_response:1; }","duration":"636.414824ms","start":"2026-03-25T07:30:38.69455Z","end":"2026-03-25T07:30:39.330965Z","steps":["trace[1678921688] 'process raft request'  (duration: 636.300913ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T07:30:39.331593Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T07:30:38.69454Z","time spent":"637.007454ms","remote":"127.0.0.1:39958","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:473 > 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-03-25T07:30:39.330967Z","caller":"traceutil/trace.go:171","msg":"trace[727413439] transaction","detail":"{read_only:false; response_revision:485; number_of_response:1; }","duration":"637.41441ms","start":"2026-03-25T07:30:38.693516Z","end":"2026-03-25T07:30:39.33093Z","steps":["trace[727413439] 'process raft request'  (duration: 637.315588ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T07:30:39.331005Z","caller":"traceutil/trace.go:171","msg":"trace[64900376] transaction","detail":"{read_only:false; response_revision:484; number_of_response:1; }","duration":"637.810066ms","start":"2026-03-25T07:30:38.693189Z","end":"2026-03-25T07:30:39.331Z","steps":["trace[64900376] 'process raft request'  (duration: 637.608973ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T07:30:39.33178Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T07:30:38.693508Z","time spent":"638.170073ms","remote":"127.0.0.1:39958","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:474 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-03-25T07:30:39.331834Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T07:30:38.693179Z","time spent":"638.618109ms","remote":"127.0.0.1:39958","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:475 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-03-25T07:30:39.331263Z","caller":"traceutil/trace.go:171","msg":"trace[475221129] transaction","detail":"{read_only:false; response_revision:482; number_of_response:1; }","duration":"637.865787ms","start":"2026-03-25T07:30:38.692944Z","end":"2026-03-25T07:30:39.33081Z","steps":["trace[475221129] 'process raft request'  (duration: 637.795636ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T07:30:39.331993Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T07:30:38.692931Z","time spent":"639.013616ms","remote":"127.0.0.1:39896","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":505,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/serviceaccounts/kube-system/cilium\" mod_revision:0 > success:<request_put:<key:\"/registry/serviceaccounts/kube-system/cilium\" value_size:453 >> failure:<>"}
{"level":"info","ts":"2026-03-25T07:30:39.330982Z","caller":"traceutil/trace.go:171","msg":"trace[327561910] transaction","detail":"{read_only:false; response_revision:483; number_of_response:1; }","duration":"637.767896ms","start":"2026-03-25T07:30:38.693137Z","end":"2026-03-25T07:30:39.330905Z","steps":["trace[327561910] 'process raft request'  (duration: 637.640034ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T07:30:39.333314Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T07:30:38.693131Z","time spent":"639.25042ms","remote":"127.0.0.1:39896","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/serviceaccounts/kube-system/cilium-operator\" mod_revision:0 > success:<request_put:<key:\"/registry/serviceaccounts/kube-system/cilium-operator\" value_size:462 >> failure:<>"}
{"level":"info","ts":"2026-03-25T07:30:39.362052Z","caller":"traceutil/trace.go:171","msg":"trace[559216770] transaction","detail":"{read_only:false; response_revision:487; number_of_response:1; }","duration":"625.679359ms","start":"2026-03-25T07:30:38.736343Z","end":"2026-03-25T07:30:39.362022Z","steps":["trace[559216770] 'process raft request'  (duration: 625.552147ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T07:30:39.36222Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T07:30:38.736327Z","time spent":"625.804051ms","remote":"127.0.0.1:39692","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/masterleases/199.204.45.138\" mod_revision:462 > success:<request_put:<key:\"/registry/masterleases/199.204.45.138\" value_size:67 lease:8471725151576817192 >> failure:<request_range:<key:\"/registry/masterleases/199.204.45.138\" > >"}
{"level":"info","ts":"2026-03-25T07:30:39.515545Z","caller":"traceutil/trace.go:171","msg":"trace[1548737932] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"177.219347ms","start":"2026-03-25T07:30:39.338286Z","end":"2026-03-25T07:30:39.515505Z","steps":["trace[1548737932] 'process raft request'  (duration: 131.190193ms)","trace[1548737932] 'compare'  (duration: 45.76965ms)"],"step_count":2}
{"level":"info","ts":"2026-03-25T07:30:39.515579Z","caller":"traceutil/trace.go:171","msg":"trace[1087490633] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"149.769039ms","start":"2026-03-25T07:30:39.365785Z","end":"2026-03-25T07:30:39.515554Z","steps":["trace[1087490633] 'process raft request'  (duration: 149.619177ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T07:30:39.515628Z","caller":"traceutil/trace.go:171","msg":"trace[391216044] linearizableReadLoop","detail":"{readStateIndex:507; appliedIndex:505; }","duration":"149.77384ms","start":"2026-03-25T07:30:39.365816Z","end":"2026-03-25T07:30:39.51559Z","steps":["trace[391216044] 'read index received'  (duration: 103.673764ms)","trace[391216044] 'applied index is now lower than readState.Index'  (duration: 46.095816ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-25T07:30:39.597327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.494324ms","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-03-25T07:30:39.597424Z","caller":"traceutil/trace.go:171","msg":"trace[489963799] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:489; }","duration":"231.628095ms","start":"2026-03-25T07:30:39.365771Z","end":"2026-03-25T07:30:39.597399Z","steps":["trace[489963799] 'agreement among raft nodes before linearized reading'  (duration: 149.905721ms)","trace[489963799] 'range keys from in-memory index tree'  (duration: 81.561592ms)"],"step_count":2}
{"level":"info","ts":"2026-03-25T07:30:39.647162Z","caller":"traceutil/trace.go:171","msg":"trace[889242165] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"125.417332ms","start":"2026-03-25T07:30:39.521709Z","end":"2026-03-25T07:30:39.647127Z","steps":["trace[889242165] 'process raft request'  (duration: 99.477719ms)","trace[889242165] 'compare'  (duration: 25.73669ms)"],"step_count":2}
{"level":"info","ts":"2026-03-25T07:30:39.938565Z","caller":"traceutil/trace.go:171","msg":"trace[350067645] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"120.847538ms","start":"2026-03-25T07:30:39.817695Z","end":"2026-03-25T07:30:39.938543Z","steps":["trace[350067645] 'process raft request'  (duration: 70.351933ms)","trace[350067645] 'compare'  (duration: 50.387254ms)"],"step_count":2}
{"level":"info","ts":"2026-03-25T07:30:40.103773Z","caller":"traceutil/trace.go:171","msg":"trace[2110677077] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"155.409782ms","start":"2026-03-25T07:30:39.948327Z","end":"2026-03-25T07:30:40.103737Z","steps":["trace[2110677077] 'process raft request'  (duration: 120.100522ms)","trace[2110677077] 'compare'  (duration: 35.126057ms)"],"step_count":2}
{"level":"info","ts":"2026-03-25T07:30:40.114298Z","caller":"traceutil/trace.go:171","msg":"trace[1837516766] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"111.053193ms","start":"2026-03-25T07:30:40.00322Z","end":"2026-03-25T07:30:40.114273Z","steps":["trace[1837516766] 'process raft request'  (duration: 110.909341ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T07:30:40.416961Z","caller":"traceutil/trace.go:171","msg":"trace[1136126844] transaction","detail":"{read_only:false; response_revision:502; number_of_response:1; }","duration":"296.634659ms","start":"2026-03-25T07:30:40.120303Z","end":"2026-03-25T07:30:40.416937Z","steps":["trace[1136126844] 'process raft request'  (duration: 296.564328ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T07:30:40.417037Z","caller":"traceutil/trace.go:171","msg":"trace[903531458] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"298.271585ms","start":"2026-03-25T07:30:40.11872Z","end":"2026-03-25T07:30:40.416992Z","steps":["trace[903531458] 'process raft request'  (duration: 206.028351ms)","trace[903531458] 'compare'  (duration: 91.931299ms)"],"step_count":2}
{"level":"info","ts":"2026-03-25T07:30:40.421454Z","caller":"traceutil/trace.go:171","msg":"trace[1336671289] linearizableReadLoop","detail":"{readStateIndex:523; appliedIndex:519; }","duration":"181.689775ms","start":"2026-03-25T07:30:40.239747Z","end":"2026-03-25T07:30:40.421437Z","steps":["trace[1336671289] 'read index received'  (duration: 85.084221ms)","trace[1336671289] 'applied index is now lower than readState.Index'  (duration: 96.604704ms)"],"step_count":2}
{"level":"info","ts":"2026-03-25T07:30:40.42155Z","caller":"traceutil/trace.go:171","msg":"trace[1382774611] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"258.916111ms","start":"2026-03-25T07:30:40.162625Z","end":"2026-03-25T07:30:40.421541Z","steps":["trace[1382774611] 'process raft request'  (duration: 258.779209ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T07:30:40.421759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.99323ms","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-03-25T07:30:40.421814Z","caller":"traceutil/trace.go:171","msg":"trace[1500815712] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:504; }","duration":"182.103411ms","start":"2026-03-25T07:30:40.239698Z","end":"2026-03-25T07:30:40.421802Z","steps":["trace[1500815712] 'agreement among raft nodes before linearized reading'  (duration: 181.937728ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T07:30:40.421563Z","caller":"traceutil/trace.go:171","msg":"trace[438729980] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"259.54803ms","start":"2026-03-25T07:30:40.161978Z","end":"2026-03-25T07:30:40.421526Z","steps":["trace[438729980] 'process raft request'  (duration: 259.348457ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T07:30:40.422623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.370417ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" ","response":"range_response_count:4 size:329948"}
{"level":"info","ts":"2026-03-25T07:30:40.422859Z","caller":"traceutil/trace.go:171","msg":"trace[106381730] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:4; response_revision:504; }","duration":"172.5226ms","start":"2026-03-25T07:30:40.250172Z","end":"2026-03-25T07:30:40.422694Z","steps":["trace[106381730] 'agreement among raft nodes before linearized reading'  (duration: 171.92504ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T07:30:40.609651Z","caller":"traceutil/trace.go:171","msg":"trace[1065431712] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"180.533586ms","start":"2026-03-25T07:30:40.429085Z","end":"2026-03-25T07:30:40.609618Z","steps":["trace[1065431712] 'process raft request'  (duration: 180.247261ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T07:30:40.609875Z","caller":"traceutil/trace.go:171","msg":"trace[572405626] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"181.256267ms","start":"2026-03-25T07:30:40.428603Z","end":"2026-03-25T07:30:40.609859Z","steps":["trace[572405626] 'process raft request'  (duration: 131.258334ms)","trace[572405626] 'compare'  (duration: 49.319263ms)"],"step_count":2}
{"level":"info","ts":"2026-03-25T07:30:40.609985Z","caller":"traceutil/trace.go:171","msg":"trace[1138290690] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"179.876426ms","start":"2026-03-25T07:30:40.430049Z","end":"2026-03-25T07:30:40.609925Z","steps":["trace[1138290690] 'process raft request'  (duration: 179.438339ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T07:30:40.610134Z","caller":"traceutil/trace.go:171","msg":"trace[847491542] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"178.481643ms","start":"2026-03-25T07:30:40.431629Z","end":"2026-03-25T07:30:40.610111Z","steps":["trace[847491542] 'process raft request'  (duration: 177.917115ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T07:30:40.610176Z","caller":"traceutil/trace.go:171","msg":"trace[1119041128] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"180.970563ms","start":"2026-03-25T07:30:40.429194Z","end":"2026-03-25T07:30:40.610165Z","steps":["trace[1119041128] 'process raft request'  (duration: 180.190261ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T07:30:40.610334Z","caller":"traceutil/trace.go:171","msg":"trace[2048669402] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"180.937093ms","start":"2026-03-25T07:30:40.42938Z","end":"2026-03-25T07:30:40.610317Z","steps":["trace[2048669402] 'process raft request'  (duration: 180.051099ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T07:30:40.610384Z","caller":"traceutil/trace.go:171","msg":"trace[1577555049] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"175.022477ms","start":"2026-03-25T07:30:40.43535Z","end":"2026-03-25T07:30:40.610372Z","steps":["trace[1577555049] 'process raft request'  (duration: 174.313966ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T07:30:42.404892Z","caller":"traceutil/trace.go:171","msg":"trace[1912708985] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"133.648619ms","start":"2026-03-25T07:30:42.271217Z","end":"2026-03-25T07:30:42.404866Z","steps":["trace[1912708985] 'process raft request'  (duration: 133.390594ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T07:30:48.790961Z","caller":"traceutil/trace.go:171","msg":"trace[612688189] transaction","detail":"{read_only:false; response_revision:563; number_of_response:1; }","duration":"147.130001ms","start":"2026-03-25T07:30:48.643805Z","end":"2026-03-25T07:30:48.790935Z","steps":["trace[612688189] 'process raft request'  (duration: 146.979988ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T07:30:49.093435Z","caller":"traceutil/trace.go:171","msg":"trace[1452761640] linearizableReadLoop","detail":"{readStateIndex:584; appliedIndex:583; }","duration":"139.182524ms","start":"2026-03-25T07:30:48.954235Z","end":"2026-03-25T07:30:49.093418Z","steps":["trace[1452761640] 'read index received'  (duration: 68.211809ms)","trace[1452761640] 'applied index is now lower than readState.Index'  (duration: 70.970125ms)"],"step_count":2}
{"level":"info","ts":"2026-03-25T07:30:49.093465Z","caller":"traceutil/trace.go:171","msg":"trace[1816132854] transaction","detail":"{read_only:false; response_revision:564; number_of_response:1; }","duration":"197.813206ms","start":"2026-03-25T07:30:48.895624Z","end":"2026-03-25T07:30:49.093437Z","steps":["trace[1816132854] 'process raft request'  (duration: 126.933131ms)","trace[1816132854] 'compare'  (duration: 70.633301ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-25T07:30:49.093571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.314356ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-q9rzk\" ","response":"range_response_count:1 size:16965"}
{"level":"info","ts":"2026-03-25T07:30:49.093597Z","caller":"traceutil/trace.go:171","msg":"trace[2041094848] range","detail":"{range_begin:/registry/pods/kube-system/cilium-q9rzk; range_end:; response_count:1; response_revision:564; }","duration":"139.398547ms","start":"2026-03-25T07:30:48.954192Z","end":"2026-03-25T07:30:49.093591Z","steps":["trace[2041094848] 'agreement among raft nodes before linearized reading'  (duration: 139.286255ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T07:30:50.232428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"850.14144ms","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-03-25T07:30:50.23254Z","caller":"traceutil/trace.go:171","msg":"trace[1932216122] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:566; }","duration":"850.259881ms","start":"2026-03-25T07:30:49.382226Z","end":"2026-03-25T07:30:50.232486Z","steps":["trace[1932216122] 'range keys from in-memory index tree'  (duration: 849.974887ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T07:30:50.232586Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T07:30:49.382205Z","time spent":"850.370053ms","remote":"127.0.0.1:39958","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-03-25T07:30:50.232618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"844.680667ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-25T07:30:50.23265Z","caller":"traceutil/trace.go:171","msg":"trace[1210765127] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:566; }","duration":"844.763677ms","start":"2026-03-25T07:30:49.387877Z","end":"2026-03-25T07:30:50.232641Z","steps":["trace[1210765127] 'range keys from in-memory index tree'  (duration: 844.587115ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T07:30:50.232676Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T07:30:49.387852Z","time spent":"844.817909ms","remote":"127.0.0.1:39672","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-03-25T07:30:50.232708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"830.959868ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-03-25T07:30:50.232745Z","caller":"traceutil/trace.go:171","msg":"trace[780421336] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:566; }","duration":"831.0226ms","start":"2026-03-25T07:30:49.401714Z","end":"2026-03-25T07:30:50.232736Z","steps":["trace[780421336] 'range keys from in-memory index tree'  (duration: 830.853246ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T07:30:50.232766Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T07:30:49.401702Z","time spent":"831.05845ms","remote":"127.0.0.1:39958","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-03-25T07:30:50.232895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"844.520004ms","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-03-25T07:30:50.232981Z","caller":"traceutil/trace.go:171","msg":"trace[600766293] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:566; }","duration":"844.664956ms","start":"2026-03-25T07:30:49.388297Z","end":"2026-03-25T07:30:50.232962Z","steps":["trace[600766293] 'range keys from in-memory index tree'  (duration: 844.341101ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T07:30:50.23303Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T07:30:49.388287Z","time spent":"844.733997ms","remote":"127.0.0.1:39958","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":"info","ts":"2026-03-25T07:30:52.399607Z","caller":"traceutil/trace.go:171","msg":"trace[823735019] linearizableReadLoop","detail":"{readStateIndex:616; appliedIndex:615; }","duration":"144.798932ms","start":"2026-03-25T07:30:52.254792Z","end":"2026-03-25T07:30:52.399591Z","steps":["trace[823735019] 'read index received'  (duration: 144.765182ms)","trace[823735019] 'applied index is now lower than readState.Index'  (duration: 33.09µs)"],"step_count":2}
{"level":"info","ts":"2026-03-25T07:30:52.399705Z","caller":"traceutil/trace.go:171","msg":"trace[1438235525] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"247.425387ms","start":"2026-03-25T07:30:52.152268Z","end":"2026-03-25T07:30:52.399693Z","steps":["trace[1438235525] 'process raft request'  (duration: 247.243604ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T07:30:52.399901Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.098257ms","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-03-25T07:30:52.399956Z","caller":"traceutil/trace.go:171","msg":"trace[707817826] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:596; }","duration":"145.194979ms","start":"2026-03-25T07:30:52.254747Z","end":"2026-03-25T07:30:52.399942Z","steps":["trace[707817826] 'agreement among raft nodes before linearized reading'  (duration: 144.995305ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T07:30:52.405798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.44528ms","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-03-25T07:30:52.405853Z","caller":"traceutil/trace.go:171","msg":"trace[109083158] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:597; }","duration":"118.539722ms","start":"2026-03-25T07:30:52.287299Z","end":"2026-03-25T07:30:52.405839Z","steps":["trace[109083158] 'agreement among raft nodes before linearized reading'  (duration: 118.328829ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T07:30:52.405885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.509182ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-03-25T07:30:52.405933Z","caller":"traceutil/trace.go:171","msg":"trace[1882605729] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:597; }","duration":"118.578522ms","start":"2026-03-25T07:30:52.287343Z","end":"2026-03-25T07:30:52.405922Z","steps":["trace[1882605729] 'agreement among raft nodes before linearized reading'  (duration: 118.42065ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T07:31:07.395032Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8471725151576817692,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-25T07:31:07.895494Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8471725151576817692,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-25T07:31:08.395687Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8471725151576817692,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-25T07:31:08.819214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.99191559s","expected-duration":"100ms","prefix":"","request":"header:<ID:8471725151576817693 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:750 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-25T07:31:08.819282Z","caller":"traceutil/trace.go:171","msg":"trace[1645295139] transaction","detail":"{read_only:false; response_revision:754; number_of_response:1; }","duration":"2.201067909s","start":"2026-03-25T07:31:06.618203Z","end":"2026-03-25T07:31:08.819271Z","steps":["trace[1645295139] 'process raft request'  (duration: 209.045637ms)","trace[1645295139] 'compare'  (duration: 1.991813339s)"],"step_count":2}
{"level":"warn","ts":"2026-03-25T07:31:08.819312Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T07:31:06.618184Z","time spent":"2.20111447s","remote":"127.0.0.1:39958","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:750 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-03-25T07:31:08.857531Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.030203723s","expected-duration":"1s"}
{"level":"info","ts":"2026-03-25T07:31:08.858154Z","caller":"traceutil/trace.go:171","msg":"trace[1849618744] transaction","detail":"{read_only:false; response_revision:755; number_of_response:1; }","duration":"2.239675677s","start":"2026-03-25T07:31:06.618394Z","end":"2026-03-25T07:31:08.85807Z","steps":["trace[1849618744] 'process raft request'  (duration: 2.239501605s)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T07:31:08.858385Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T07:31:06.618366Z","time spent":"2.23986457s","remote":"127.0.0.1:39958","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:749 > 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-03-25T07:31:09.388052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999887199s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-03-25T07:31:09.388135Z","caller":"traceutil/trace.go:171","msg":"trace[341532096] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000019961s","start":"2026-03-25T07:31:07.388095Z","end":"2026-03-25T07:31:09.388115Z","steps":["trace[341532096] 'agreement among raft nodes before linearized reading'  (duration: 1.999917649s)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T07:31:09.388181Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T07:31:07.388077Z","time spent":"2.000094671s","remote":"127.0.0.1:39666","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-03-25T07:31:11.38887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000245216s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-03-25T07:31:11.388969Z","caller":"traceutil/trace.go:171","msg":"trace[607332747] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000364698s","start":"2026-03-25T07:31:09.388581Z","end":"2026-03-25T07:31:11.388945Z","steps":["trace[607332747] 'agreement among raft nodes before linearized reading'  (duration: 2.000238436s)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T07:31:11.389029Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T07:31:09.388545Z","time spent":"2.000470529s","remote":"127.0.0.1:39672","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
2026/03/25 07:31:11 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-03-25T07:31:11.89515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.000120066s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-03-25T07:31:11.895254Z","caller":"traceutil/trace.go:171","msg":"trace[605328743] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; }","duration":"5.000283649s","start":"2026-03-25T07:31:06.894947Z","end":"2026-03-25T07:31:11.89523Z","steps":["trace[605328743] 'agreement among raft nodes before linearized reading'  (duration: 5.000154117s)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T07:31:11.895314Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T07:31:06.894926Z","time spent":"5.00037288s","remote":"127.0.0.1:39958","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/03/25 07:31:11 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-03-25T07:31:13.089016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.999232523s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-03-25T07:31:13.089081Z","caller":"traceutil/trace.go:171","msg":"trace[1346355908] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; }","duration":"4.999348574s","start":"2026-03-25T07:31:08.089718Z","end":"2026-03-25T07:31:13.089067Z","steps":["trace[1346355908] 'agreement among raft nodes before linearized reading'  (duration: 4.999259553s)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T07:31:13.089122Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T07:31:08.089701Z","time spent":"4.999414275s","remote":"127.0.0.1:39958","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\" "}
{"level":"warn","ts":"2026-03-25T07:31:13.398186Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000174994s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-03-25T07:31:13.398285Z","caller":"traceutil/trace.go:171","msg":"trace[1314516512] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000388407s","start":"2026-03-25T07:31:11.397877Z","end":"2026-03-25T07:31:13.398266Z","steps":["trace[1314516512] 'agreement among raft nodes before linearized reading'  (duration: 2.000209714s)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T07:31:13.398336Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T07:31:11.397857Z","time spent":"2.000459808s","remote":"127.0.0.1:39666","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
2026/03/25 07:31:13 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-03-25T07:31:13.617615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.999911502s","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-03-25T07:31:13.617745Z","caller":"traceutil/trace.go:171","msg":"trace[49259829] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; }","duration":"5.000059874s","start":"2026-03-25T07:31:08.617621Z","end":"2026-03-25T07:31:13.61768Z","steps":["trace[49259829] 'agreement among raft nodes before linearized reading'  (duration: 4.999937002s)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T07:31:13.617884Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T07:31:08.617605Z","time spent":"5.000262477s","remote":"127.0.0.1:39958","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\" "}
{"level":"warn","ts":"2026-03-25T07:31:14.026794Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T07:31:07.025854Z","time spent":"7.000934378s","remote":"127.0.0.1:39738","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"warn","ts":"2026-03-25T07:31:14.37147Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T07:31:07.370362Z","time spent":"7.001102223s","remote":"127.0.0.1:39848","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""}
{"level":"warn","ts":"2026-03-25T07:31:15.399205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000885831s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-03-25T07:31:15.399312Z","caller":"traceutil/trace.go:171","msg":"trace[1081288943] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.001039984s","start":"2026-03-25T07:31:13.39825Z","end":"2026-03-25T07:31:15.39929Z","steps":["trace[1081288943] 'agreement among raft nodes before linearized reading'  (duration: 2.000913932s)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T07:31:15.39936Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T07:31:13.398228Z","time spent":"2.001121955s","remote":"127.0.0.1:39672","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
2026/03/25 07:31:15 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-03-25T07:31:15.671219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000976616s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-03-25T07:31:15.671316Z","caller":"traceutil/trace.go:171","msg":"trace[1154508214] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.001122707s","start":"2026-03-25T07:31:13.670173Z","end":"2026-03-25T07:31:15.671296Z","steps":["trace[1154508214] 'agreement among raft nodes before linearized reading'  (duration: 2.001001835s)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T07:31:15.671368Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T07:31:13.670156Z","time spent":"2.001202509s","remote":"127.0.0.1:39666","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
2026/03/25 07:31:15 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-03-25T07:31:16.039775Z","caller":"etcdserver/server.go:1165","msg":"failed to revoke lease","lease-id":"75919d23e67a7f22","error":"etcdserver: request timed out"}
{"level":"warn","ts":"2026-03-25T07:31:16.560698Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T07:31:09.560142Z","time spent":"7.000547456s","remote":"127.0.0.1:39958","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""}
{"level":"warn","ts":"2026-03-25T07:31:16.871761Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T07:31:09.871197Z","time spent":"7.000553724s","remote":"127.0.0.1:39958","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""}
{"level":"warn","ts":"2026-03-25T07:31:16.894754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.997607725s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-03-25T07:31:16.894917Z","caller":"traceutil/trace.go:171","msg":"trace[2086624186] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; }","duration":"2.997848388s","start":"2026-03-25T07:31:13.897048Z","end":"2026-03-25T07:31:16.894897Z","steps":["trace[2086624186] 'agreement among raft nodes before linearized reading'  (duration: 2.997644755s)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T07:31:16.895003Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T07:31:13.897025Z","time spent":"2.997935581s","remote":"127.0.0.1:39958","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/03/25 07:31:16 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-03-25T07:31:17.408017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000519377s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-03-25T07:31:17.408152Z","caller":"traceutil/trace.go:171","msg":"trace[1545091557] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000726119s","start":"2026-03-25T07:31:15.407395Z","end":"2026-03-25T07:31:17.408121Z","steps":["trace[1545091557] 'agreement among raft nodes before linearized reading'  (duration: 2.000541067s)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T07:31:17.408226Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T07:31:15.407378Z","time spent":"2.000835791s","remote":"127.0.0.1:39666","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
2026/03/25 07:31:17 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-03-25T07:31:18.088829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.996923521s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-03-25T07:31:18.088908Z","caller":"traceutil/trace.go:171","msg":"trace[57581851] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; }","duration":"2.997049183s","start":"2026-03-25T07:31:15.09184Z","end":"2026-03-25T07:31:18.088889Z","steps":["trace[57581851] 'agreement among raft nodes before linearized reading'  (duration: 2.996950262s)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T07:31:18.088955Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T07:31:15.09182Z","time spent":"2.997125774s","remote":"127.0.0.1:39958","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/03/25 07:31:18 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-03-25T07:31:18.618208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.998554238s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-03-25T07:31:18.618327Z","caller":"traceutil/trace.go:171","msg":"trace[177340257] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; }","duration":"2.99873678s","start":"2026-03-25T07:31:15.619562Z","end":"2026-03-25T07:31:18.618299Z","steps":["trace[177340257] 'agreement among raft nodes before linearized reading'  (duration: 2.998583818s)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T07:31:18.61839Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T07:31:15.619539Z","time spent":"2.998839181s","remote":"127.0.0.1:39958","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/03/25 07:31:18 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-03-25T07:31:18.642891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"7.548675612s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" limit:500 ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-03-25T07:31:18.64295Z","caller":"traceutil/trace.go:171","msg":"trace[1327151646] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; }","duration":"7.548751724s","start":"2026-03-25T07:31:11.094181Z","end":"2026-03-25T07:31:18.642933Z","steps":["trace[1327151646] 'agreement among raft nodes before linearized reading'  (duration: 7.548685643s)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T07:31:18.642945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"7.575258949s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" limit:500 ","response":"","error":"context canceled"}
{"level":"warn","ts":"2026-03-25T07:31:18.64299Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T07:31:11.094174Z","time spent":"7.548805125s","remote":"127.0.0.1:39638","response type":"/etcdserverpb.KV/Range","request count":0,"request size":81,"response count":0,"response size":0,"request content":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" limit:500 "}
2026/03/25 07:31:18 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"info","ts":"2026-03-25T07:31:18.64304Z","caller":"traceutil/trace.go:171","msg":"trace[1598468908] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; }","duration":"7.575411462s","start":"2026-03-25T07:31:11.067607Z","end":"2026-03-25T07:31:18.643018Z","steps":["trace[1598468908] 'agreement among raft nodes before linearized reading'  (duration: 7.575273159s)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T07:31:18.643103Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T07:31:11.067599Z","time spent":"7.575492673s","remote":"127.0.0.1:39626","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":0,"request content":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" limit:500 "}
2026/03/25 07:31:18 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-03-25T07:31:18.644223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"7.560308302s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" limit:500 ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-03-25T07:31:18.644275Z","caller":"traceutil/trace.go:171","msg":"trace[1409559989] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; }","duration":"7.560384424s","start":"2026-03-25T07:31:11.08388Z","end":"2026-03-25T07:31:18.644265Z","steps":["trace[1409559989] 'agreement among raft nodes before linearized reading'  (duration: 7.560316823s)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T07:31:18.644311Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T07:31:11.083876Z","time spent":"7.560424445s","remote":"127.0.0.1:39630","response type":"/etcdserverpb.KV/Range","request count":0,"request size":95,"response count":0,"response size":0,"request content":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" limit:500 "}
2026/03/25 07:31:18 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-03-25T07:31:18.644332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"7.895840599s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" limit:500 ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-03-25T07:31:18.644409Z","caller":"traceutil/trace.go:171","msg":"trace[1727366375] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; }","duration":"7.895970821s","start":"2026-03-25T07:31:10.748421Z","end":"2026-03-25T07:31:18.644392Z","steps":["trace[1727366375] 'agreement among raft nodes before linearized reading'  (duration: 7.895856389s)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T07:31:18.644502Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T07:31:10.748413Z","time spent":"7.896050502s","remote":"127.0.0.1:39616","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":0,"response size":0,"request content":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" limit:500 "}
2026/03/25 07:31:18 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-03-25T07:31:19.409031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000310871s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-03-25T07:31:19.409147Z","caller":"traceutil/trace.go:171","msg":"trace[1606079569] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000498523s","start":"2026-03-25T07:31:17.408621Z","end":"2026-03-25T07:31:19.40912Z","steps":["trace[1606079569] 'agreement among raft nodes before linearized reading'  (duration: 2.000340871s)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T07:31:19.409228Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T07:31:17.408593Z","time spent":"2.000621426s","remote":"127.0.0.1:39672","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
2026/03/25 07:31:19 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-03-25T07:31:20.824319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"9.999684407s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-03-25T07:31:20.82439Z","caller":"traceutil/trace.go:171","msg":"trace[1709907909] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; }","duration":"9.999805629s","start":"2026-03-25T07:31:10.824567Z","end":"2026-03-25T07:31:20.824373Z","steps":["trace[1709907909] 'agreement among raft nodes before linearized reading'  (duration: 9.999713848s)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T07:31:20.824432Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T07:31:10.824551Z","time spent":"9.9998703s","remote":"127.0.0.1:39958","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
2026/03/25 07:31:20 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-03-25T07:31:20.862237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"9.999329585s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-03-25T07:31:20.862336Z","caller":"traceutil/trace.go:171","msg":"trace[2142810194] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; }","duration":"9.999501558s","start":"2026-03-25T07:31:10.862811Z","end":"2026-03-25T07:31:20.862313Z","steps":["trace[2142810194] 'agreement among raft nodes before linearized reading'  (duration: 9.999364176s)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T07:31:20.8624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T07:31:10.862791Z","time spent":"9.999587869s","remote":"127.0.0.1:39958","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
2026/03/25 07:31:20 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-03-25T07:31:21.418734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000114332s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-03-25T07:31:21.418895Z","caller":"traceutil/trace.go:171","msg":"trace[550319660] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000295824s","start":"2026-03-25T07:31:19.41858Z","end":"2026-03-25T07:31:21.418876Z","steps":["trace[550319660] 'agreement among raft nodes before linearized reading'  (duration: 2.000111622s)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T07:31:21.418995Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T07:31:19.418493Z","time spent":"2.000474556s","remote":"127.0.0.1:39666","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-03-25T07:31:21.600004Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"12.742206068s","expected-duration":"1s"}
{"level":"warn","ts":"2026-03-25T07:31:21.789367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.103304ms","expected-duration":"100ms","prefix":"","request":"header:<ID:8471725151576817696 username:\"kube-apiserver-etcd-client\" auth_revision:1 > lease_grant:<ttl:3660-second id:75919d23e67a801f>","response":"size:42"}
{"level":"warn","ts":"2026-03-25T07:31:21.78955Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T07:31:20.341651Z","time spent":"1.447895084s","remote":"127.0.0.1:39234","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"warn","ts":"2026-03-25T07:31:21.789663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.482999719s","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-03-25T07:31:21.789722Z","caller":"traceutil/trace.go:171","msg":"trace[1351304794] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:755; }","duration":"5.48306769s","start":"2026-03-25T07:31:16.306643Z","end":"2026-03-25T07:31:21.78971Z","steps":["trace[1351304794] 'range keys from in-memory index tree'  (duration: 5.482988048s)"],"step_count":1}
{"level":"info","ts":"2026-03-25T07:31:21.790645Z","caller":"traceutil/trace.go:171","msg":"trace[1641271789] linearizableReadLoop","detail":"{readStateIndex:782; appliedIndex:779; }","duration":"14.895621467s","start":"2026-03-25T07:31:06.894998Z","end":"2026-03-25T07:31:21.79062Z","steps":["trace[1641271789] 'read index received'  (duration: 1.962827026s)","trace[1641271789] 'applied index is now lower than readState.Index'  (duration: 12.932793431s)"],"step_count":2}
{"level":"warn","ts":"2026-03-25T07:31:21.895487Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T07:31:16.897366Z","time spent":"4.998111247s","remote":"127.0.0.1:39958","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""}
2026/03/25 07:31:21 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-03-25T07:31:21.984381Z","caller":"etcdserver/util.go:123","msg":"failed to apply request","took":"118.992µs","request":"header:<ID:8471725151576817701 > lease_revoke:<id:75919d23e67a7f22>","response":"size:29","error":"lease not found"}
{"level":"warn","ts":"2026-03-25T07:31:21.984611Z","caller":"etcdserver/server.go:1165","msg":"failed to revoke lease","lease-id":"75919d23e67a7f22","error":"lease not found"}
{"level":"info","ts":"2026-03-25T07:31:21.984677Z","caller":"traceutil/trace.go:171","msg":"trace[164504561] transaction","detail":"{read_only:false; number_of_response:1; response_revision:758; }","duration":"5.418764834s","start":"2026-03-25T07:31:16.565887Z","end":"2026-03-25T07:31:21.984652Z","steps":["trace[164504561] 'process raft request'  (duration: 5.418581221s)"],"step_count":1}
{"level":"info","ts":"2026-03-25T07:31:21.984697Z","caller":"traceutil/trace.go:171","msg":"trace[177045191] transaction","detail":"{read_only:false; number_of_response:1; response_revision:758; }","duration":"5.107091319s","start":"2026-03-25T07:31:16.877587Z","end":"2026-03-25T07:31:21.984679Z","steps":["trace[177045191] 'process raft request'  (duration: 5.106971097s)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T07:31:21.984809Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T07:31:16.87756Z","time spent":"5.107174651s","remote":"127.0.0.1:39958","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":45,"response count":0,"response size":571,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:682 > 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-03-25T07:31:21.984831Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T07:31:16.565862Z","time spent":"5.418867886s","remote":"127.0.0.1:39958","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":69,"response count":0,"response size":722,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:681 > 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-03-25T07:31:21.985067Z","caller":"traceutil/trace.go:171","msg":"trace[1993925185] transaction","detail":"{read_only:false; response_revision:760; number_of_response:1; }","duration":"3.893442162s","start":"2026-03-25T07:31:18.091607Z","end":"2026-03-25T07:31:21.985049Z","steps":["trace[1993925185] 'process raft request'  (duration: 3.893050646s)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T07:31:21.985158Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T07:31:18.091585Z","time spent":"3.893527173s","remote":"127.0.0.1:39958","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":456,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:752 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:390 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-03-25T07:31:21.997717Z","caller":"traceutil/trace.go:171","msg":"trace[1001682934] linearizableReadLoop","detail":"{readStateIndex:793; appliedIndex:782; }","duration":"207.023971ms","start":"2026-03-25T07:31:21.790677Z","end":"2026-03-25T07:31:21.997701Z","steps":["trace[1001682934] 'read index received'  (duration: 134.340935ms)","trace[1001682934] 'applied index is now lower than readState.Index'  (duration: 72.682246ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-25T07:31:21.997843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"8.662437119s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"warn","ts":"2026-03-25T07:31:21.997864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"8.540050885s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-25T07:31:21.997893Z","caller":"traceutil/trace.go:171","msg":"trace[2049667495] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:763; }","duration":"8.540134127s","start":"2026-03-25T07:31:13.457753Z","end":"2026-03-25T07:31:21.997887Z","steps":["trace[2049667495] 'agreement among raft nodes before linearized reading'  (duration: 8.540006835s)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T07:31:21.997908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"9.780515817s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"warn","ts":"2026-03-25T07:31:21.997897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.283191328s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-25T07:31:21.997931Z","caller":"traceutil/trace.go:171","msg":"trace[1141980155] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:763; }","duration":"9.780570667s","start":"2026-03-25T07:31:12.217351Z","end":"2026-03-25T07:31:21.997922Z","steps":["trace[1141980155] 'agreement among raft nodes before linearized reading'  (duration: 9.780533227s)"],"step_count":1}
{"level":"info","ts":"2026-03-25T07:31:21.997944Z","caller":"traceutil/trace.go:171","msg":"trace[573544871] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:763; }","duration":"1.283271789s","start":"2026-03-25T07:31:20.71466Z","end":"2026-03-25T07:31:21.997931Z","steps":["trace[573544871] 'agreement among raft nodes before linearized reading'  (duration: 1.283203028s)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T07:31:21.997946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.249287509s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"warn","ts":"2026-03-25T07:31:21.997958Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T07:31:12.217329Z","time spent":"9.780622587s","remote":"127.0.0.1:40142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":8,"response size":31,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "}
{"level":"info","ts":"2026-03-25T07:31:21.997976Z","caller":"traceutil/trace.go:171","msg":"trace[869354023] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:763; }","duration":"5.24935262s","start":"2026-03-25T07:31:16.748617Z","end":"2026-03-25T07:31:21.997969Z","steps":["trace[869354023] 'agreement among raft nodes before linearized reading'  (duration: 5.249312589s)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T07:31:21.997977Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T07:31:20.714639Z","time spent":"1.2833292s","remote":"127.0.0.1:40192","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":2,"response size":31,"request content":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true "}
{"level":"warn","ts":"2026-03-25T07:31:21.997993Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T07:31:16.748595Z","time spent":"5.249393261s","remote":"127.0.0.1:39948","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":1,"response size":31,"request content":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true "}
{"level":"warn","ts":"2026-03-25T07:31:21.997994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.012863079s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-25T07:31:21.998028Z","caller":"traceutil/trace.go:171","msg":"trace[2001028576] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:763; }","duration":"2.01294438s","start":"2026-03-25T07:31:19.985069Z","end":"2026-03-25T07:31:21.998013Z","steps":["trace[2001028576] 'agreement among raft nodes before linearized reading'  (duration: 2.01290551s)"],"step_count":1}
{"level":"info","ts":"2026-03-25T07:31:21.998022Z","caller":"traceutil/trace.go:171","msg":"trace[744387378] transaction","detail":"{read_only:false; response_revision:763; number_of_response:1; }","duration":"1.132897863s","start":"2026-03-25T07:31:20.865079Z","end":"2026-03-25T07:31:21.997977Z","steps":["trace[744387378] 'process raft request'  (duration: 1.132575779s)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T07:31:21.998055Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T07:31:19.985036Z","time spent":"2.013011792s","remote":"127.0.0.1:39916","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":29,"request content":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true "}
{"level":"warn","ts":"2026-03-25T07:31:21.998115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"578.449959ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-25T07:31:21.998125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"10.904151827s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-25T07:31:21.998134Z","caller":"traceutil/trace.go:171","msg":"trace[2103730786] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:763; }","duration":"578.469699ms","start":"2026-03-25T07:31:21.419659Z","end":"2026-03-25T07:31:21.998129Z","steps":["trace[2103730786] 'agreement among raft nodes before linearized reading'  (duration: 578.435658ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T07:31:21.998149Z","caller":"traceutil/trace.go:171","msg":"trace[607928840] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:763; }","duration":"10.904175057s","start":"2026-03-25T07:31:11.093966Z","end":"2026-03-25T07:31:21.998141Z","steps":["trace[607928840] 'agreement among raft nodes before linearized reading'  (duration: 10.904138536s)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T07:31:21.998152Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T07:31:21.419595Z","time spent":"578.554199ms","remote":"127.0.0.1:39672","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-03-25T07:31:21.998168Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T07:31:11.093908Z","time spent":"10.904255428s","remote":"127.0.0.1:39638","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true "}
{"level":"warn","ts":"2026-03-25T07:31:21.998173Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T07:31:20.865043Z","time spent":"1.133044884s","remote":"127.0.0.1:39958","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":415,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:755 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:363 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-03-25T07:31:21.997869Z","caller":"traceutil/trace.go:171","msg":"trace[1707540852] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:763; }","duration":"8.662483989s","start":"2026-03-25T07:31:13.335376Z","end":"2026-03-25T07:31:21.99786Z","steps":["trace[1707540852] 'agreement among raft nodes before linearized reading'  (duration: 8.662414908s)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T07:31:21.998295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"7.624058358s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:5401"}
{"level":"warn","ts":"2026-03-25T07:31:21.998311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"10.904579453s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-25T07:31:21.998317Z","caller":"traceutil/trace.go:171","msg":"trace[1679795911] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:763; }","duration":"7.624104248s","start":"2026-03-25T07:31:14.374207Z","end":"2026-03-25T07:31:21.998311Z","steps":["trace[1679795911] 'agreement among raft nodes before linearized reading'  (duration: 7.623966916s)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T07:31:21.998317Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T07:31:13.335311Z","time spent":"8.662997166s","remote":"127.0.0.1:39864","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":12,"response size":31,"request content":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true "}
{"level":"info","ts":"2026-03-25T07:31:21.998332Z","caller":"traceutil/trace.go:171","msg":"trace[114900255] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:763; }","duration":"10.904620633s","start":"2026-03-25T07:31:11.093705Z","end":"2026-03-25T07:31:21.998325Z","steps":["trace[114900255] 'agreement among raft nodes before linearized reading'  (duration: 10.904586943s)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T07:31:21.998339Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T07:31:14.374192Z","time spent":"7.624141028s","remote":"127.0.0.1:39848","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":5425,"request content":"key:\"/registry/minions/instance\" "}
{"level":"warn","ts":"2026-03-25T07:31:21.998352Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T07:31:11.093696Z","time spent":"10.904651414s","remote":"127.0.0.1:39638","response type":"/etcdserverpb.KV/Range","request count":0,"request size":81,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" limit:10000 "}
{"level":"warn","ts":"2026-03-25T07:31:21.997887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.506115621s","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-03-25T07:31:21.998413Z","caller":"traceutil/trace.go:171","msg":"trace[196774120] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:763; }","duration":"2.506707689s","start":"2026-03-25T07:31:19.491698Z","end":"2026-03-25T07:31:21.998406Z","steps":["trace[196774120] 'agreement among raft nodes before linearized reading'  (duration: 2.506110702s)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T07:31:21.998432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"10.91527623s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-25T07:31:21.997914Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T07:31:13.457733Z","time spent":"8.540176037s","remote":"127.0.0.1:40232","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":108,"response size":31,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true "}
{"level":"info","ts":"2026-03-25T07:31:21.998452Z","caller":"traceutil/trace.go:171","msg":"trace[19742056] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:763; }","duration":"10.915302131s","start":"2026-03-25T07:31:11.083143Z","end":"2026-03-25T07:31:21.998445Z","steps":["trace[19742056] 'agreement among raft nodes before linearized reading'  (duration: 10.915272001s)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T07:31:21.998473Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T07:31:11.08314Z","time spent":"10.915327851s","remote":"127.0.0.1:39630","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true "}
{"level":"warn","ts":"2026-03-25T07:31:21.998494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"7.63307763s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-25T07:31:21.998511Z","caller":"traceutil/trace.go:171","msg":"trace[1304649295] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:763; }","duration":"7.633096201s","start":"2026-03-25T07:31:14.36541Z","end":"2026-03-25T07:31:21.998506Z","steps":["trace[1304649295] 'agreement among raft nodes before linearized reading'  (duration: 7.63301737s)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T07:31:21.998524Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T07:31:14.365353Z","time spent":"7.633168151s","remote":"127.0.0.1:40040","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":52,"response size":31,"request content":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true "}
{"level":"warn","ts":"2026-03-25T07:31:21.998569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"10.915431662s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-25T07:31:21.998565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"7.953848651s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-25T07:31:21.998582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"7.98383506s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.138\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-25T07:31:21.9986Z","caller":"traceutil/trace.go:171","msg":"trace[1162505557] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:763; }","duration":"7.953934042s","start":"2026-03-25T07:31:14.044657Z","end":"2026-03-25T07:31:21.998591Z","steps":["trace[1162505557] 'agreement among raft nodes before linearized reading'  (duration: 7.953877611s)"],"step_count":1}
{"level":"info","ts":"2026-03-25T07:31:21.998625Z","caller":"traceutil/trace.go:171","msg":"trace[1702767636] range","detail":"{range_begin:/registry/masterleases/199.204.45.138; range_end:; response_count:0; response_revision:763; }","duration":"7.98390503s","start":"2026-03-25T07:31:14.014708Z","end":"2026-03-25T07:31:21.998613Z","steps":["trace[1702767636] 'agreement among raft nodes before linearized reading'  (duration: 7.983824679s)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T07:31:21.998632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"10.931431343s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-25T07:31:21.998631Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T07:31:14.044634Z","time spent":"7.953987353s","remote":"127.0.0.1:39800","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":29,"request content":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true "}
{"level":"info","ts":"2026-03-25T07:31:21.997721Z","caller":"traceutil/trace.go:171","msg":"trace[1088869791] transaction","detail":"{read_only:false; response_revision:762; number_of_response:1; }","duration":"1.17169932s","start":"2026-03-25T07:31:20.826004Z","end":"2026-03-25T07:31:21.997704Z","steps":["trace[1088869791] 'process raft request'  (duration: 1.171370906s)"],"step_count":1}
{"level":"info","ts":"2026-03-25T07:31:21.998659Z","caller":"traceutil/trace.go:171","msg":"trace[460635905] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:763; }","duration":"10.931501334s","start":"2026-03-25T07:31:11.06715Z","end":"2026-03-25T07:31:21.998651Z","steps":["trace[460635905] 'agreement among raft nodes before linearized reading'  (duration: 10.931459663s)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T07:31:21.99866Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T07:31:14.014695Z","time spent":"7.983958391s","remote":"127.0.0.1:39692","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":0,"response size":29,"request content":"key:\"/registry/masterleases/199.204.45.138\" "}
{"level":"warn","ts":"2026-03-25T07:31:21.998694Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T07:31:11.067133Z","time spent":"10.931549625s","remote":"127.0.0.1:39626","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true "}
{"level":"warn","ts":"2026-03-25T07:31:21.998724Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T07:31:20.825982Z","time spent":"1.172691584s","remote":"127.0.0.1:39958","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":411,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:754 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:361 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-03-25T07:31:21.998808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"11.251051769s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-25T07:31:21.998834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"11.652741085s","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-03-25T07:31:21.998857Z","caller":"traceutil/trace.go:171","msg":"trace[1461448612] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:763; }","duration":"11.652817505s","start":"2026-03-25T07:31:10.346034Z","end":"2026-03-25T07:31:21.998851Z","steps":["trace[1461448612] 'agreement among raft nodes before linearized reading'  (duration: 11.652774735s)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T07:31:21.998868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"11.250962338s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-25T07:31:21.998875Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T07:31:10.345986Z","time spent":"11.652884946s","remote":"127.0.0.1:40170","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":2,"response size":31,"request content":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true "}
{"level":"warn","ts":"2026-03-25T07:31:21.998879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"11.025016403s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"warn","ts":"2026-03-25T07:31:21.997957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.914515137s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-25T07:31:21.998887Z","caller":"traceutil/trace.go:171","msg":"trace[1168882130] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:763; }","duration":"11.25106436s","start":"2026-03-25T07:31:10.747816Z","end":"2026-03-25T07:31:21.998881Z","steps":["trace[1168882130] 'agreement among raft nodes before linearized reading'  (duration: 11.251034259s)"],"step_count":1}
{"level":"info","ts":"2026-03-25T07:31:21.998903Z","caller":"traceutil/trace.go:171","msg":"trace[2065321226] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:763; }","duration":"11.025096975s","start":"2026-03-25T07:31:10.973799Z","end":"2026-03-25T07:31:21.998896Z","steps":["trace[2065321226] 'agreement among raft nodes before linearized reading'  (duration: 11.025047574s)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T07:31:21.998906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"7.968334118s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/kube-apiserver-instance.18a00513f106b69f\" ","response":"range_response_count:1 size:774"}
{"level":"warn","ts":"2026-03-25T07:31:21.998914Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T07:31:10.747789Z","time spent":"11.251118421s","remote":"127.0.0.1:39616","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" limit:10000 "}
{"level":"info","ts":"2026-03-25T07:31:21.998941Z","caller":"traceutil/trace.go:171","msg":"trace[1161283687] range","detail":"{range_begin:/registry/events/kube-system/kube-apiserver-instance.18a00513f106b69f; range_end:; response_count:1; response_revision:763; }","duration":"7.968404309s","start":"2026-03-25T07:31:14.030523Z","end":"2026-03-25T07:31:21.998927Z","steps":["trace[1161283687] 'agreement among raft nodes before linearized reading'  (duration: 7.968263627s)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T07:31:21.998946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"10.931877748s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-25T07:31:21.998966Z","caller":"traceutil/trace.go:171","msg":"trace[649150250] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:763; }","duration":"10.931917601s","start":"2026-03-25T07:31:11.067043Z","end":"2026-03-25T07:31:21.998961Z","steps":["trace[649150250] 'agreement among raft nodes before linearized reading'  (duration: 10.931888009s)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T07:31:21.998969Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T07:31:14.03051Z","time spent":"7.968452691s","remote":"127.0.0.1:39738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":798,"request content":"key:\"/registry/events/kube-system/kube-apiserver-instance.18a00513f106b69f\" "}
{"level":"warn","ts":"2026-03-25T07:31:21.998979Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T07:31:11.067029Z","time spent":"10.931946861s","remote":"127.0.0.1:39626","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" limit:10000 "}
{"level":"info","ts":"2026-03-25T07:31:21.998912Z","caller":"traceutil/trace.go:171","msg":"trace[106203199] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:763; }","duration":"1.91550712s","start":"2026-03-25T07:31:20.083398Z","end":"2026-03-25T07:31:21.998905Z","steps":["trace[106203199] 'agreement among raft nodes before linearized reading'  (duration: 1.914529477s)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T07:31:21.999054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"12.482442196s","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-03-25T07:31:21.998593Z","caller":"traceutil/trace.go:171","msg":"trace[326005671] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:763; }","duration":"10.915453123s","start":"2026-03-25T07:31:11.083131Z","end":"2026-03-25T07:31:21.998584Z","steps":["trace[326005671] 'agreement among raft nodes before linearized reading'  (duration: 10.915418762s)"],"step_count":1}
{"level":"info","ts":"2026-03-25T07:31:21.999123Z","caller":"traceutil/trace.go:171","msg":"trace[1411510332] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:763; }","duration":"12.482542568s","start":"2026-03-25T07:31:09.51657Z","end":"2026-03-25T07:31:21.999113Z","steps":["trace[1411510332] 'agreement among raft nodes before linearized reading'  (duration: 12.482398796s)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T07:31:21.999149Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T07:31:11.083102Z","time spent":"10.916032611s","remote":"127.0.0.1:39630","response type":"/etcdserverpb.KV/Range","request count":0,"request size":95,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" limit:10000 "}
{"level":"warn","ts":"2026-03-25T07:31:21.999174Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T07:31:09.516553Z","time spent":"12.482597548s","remote":"127.0.0.1:39880","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":2,"response size":31,"request content":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true "}
{"level":"warn","ts":"2026-03-25T07:31:21.999067Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T07:31:20.083374Z","time spent":"1.915684023s","remote":"127.0.0.1:39994","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":29,"request content":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true "}
{"level":"warn","ts":"2026-03-25T07:31:21.998919Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T07:31:10.973774Z","time spent":"11.025140545s","remote":"127.0.0.1:40016","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":13,"response size":31,"request content":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true "}
{"level":"warn","ts":"2026-03-25T07:31:21.998433Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T07:31:19.491669Z","time spent":"2.50675784s","remote":"127.0.0.1:39776","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":5,"response size":31,"request content":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true "}
{"level":"info","ts":"2026-03-25T07:31:21.998836Z","caller":"traceutil/trace.go:171","msg":"trace[2130255520] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:763; }","duration":"11.25110238s","start":"2026-03-25T07:31:10.747724Z","end":"2026-03-25T07:31:21.998826Z","steps":["trace[2130255520] 'agreement among raft nodes before linearized reading'  (duration: 11.251052859s)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T07:31:21.999435Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T07:31:10.74771Z","time spent":"11.25171731s","remote":"127.0.0.1:39616","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true "}
{"level":"warn","ts":"2026-03-25T07:31:21.99945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"14.979321806s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-67659f764b-lb5x6\" ","response":"range_response_count:1 size:5083"}
{"level":"info","ts":"2026-03-25T07:31:21.999484Z","caller":"traceutil/trace.go:171","msg":"trace[1114742056] range","detail":"{range_begin:/registry/pods/kube-system/coredns-67659f764b-lb5x6; range_end:; response_count:1; response_revision:763; }","duration":"14.979387287s","start":"2026-03-25T07:31:07.020086Z","end":"2026-03-25T07:31:21.999473Z","steps":["trace[1114742056] 'agreement among raft nodes before linearized reading'  (duration: 14.979263896s)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T07:31:21.999513Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T07:31:07.020063Z","time spent":"14.979443338s","remote":"127.0.0.1:39864","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":5107,"request content":"key:\"/registry/pods/kube-system/coredns-67659f764b-lb5x6\" "}
{"level":"info","ts":"2026-03-25T07:32:30.072203Z","caller":"traceutil/trace.go:171","msg":"trace[390563731] transaction","detail":"{read_only:false; response_revision:1026; number_of_response:1; }","duration":"243.145286ms","start":"2026-03-25T07:32:29.829033Z","end":"2026-03-25T07:32:30.072178Z","steps":["trace[390563731] 'process raft request'  (duration: 243.009774ms)"],"step_count":1}