{"level":"warn","ts":"2026-02-25T19:23:03.741608Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-02-25T19:23:03.741739Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.132: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.132:2380","--initial-cluster=instance=https://199.204.45.132:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.132:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.132: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-02-25T19:23:03.741851Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-02-25T19:23:03.741874Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.132:2380"]}
{"level":"info","ts":"2026-02-25T19:23:03.74191Z","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-02-25T19:23:03.743452Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.132:2379"]}
{"level":"info","ts":"2026-02-25T19:23:03.743597Z","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.132:2380"],"listen-peer-urls":["https://199.204.45.132:2380"],"advertise-client-urls":["https://199.204.45.132:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.132:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.132: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-02-25T19:23:03.748425Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.480755ms"}
{"level":"info","ts":"2026-02-25T19:23:03.756183Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"56c01ea8fdc90390","cluster-id":"c930fe821aab8609"}
{"level":"info","ts":"2026-02-25T19:23:03.756298Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 switched to configuration voters=()"}
{"level":"info","ts":"2026-02-25T19:23:03.756329Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 became follower at term 0"}
{"level":"info","ts":"2026-02-25T19:23:03.756345Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 56c01ea8fdc90390 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-02-25T19:23:03.756363Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 became follower at term 1"}
{"level":"info","ts":"2026-02-25T19:23:03.756405Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 switched to configuration voters=(6251029993951396752)"}
{"level":"warn","ts":"2026-02-25T19:23:03.765154Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-02-25T19:23:03.76694Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-02-25T19:23:03.768228Z","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-02-25T19:23:03.772271Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"56c01ea8fdc90390","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-02-25T19:23:03.772811Z","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-02-25T19:23:03.772888Z","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-02-25T19:23:03.772899Z","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-02-25T19:23:03.773028Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"56c01ea8fdc90390","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-02-25T19:23:03.773696Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 switched to configuration voters=(6251029993951396752)"}
{"level":"info","ts":"2026-02-25T19:23:03.775196Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"c930fe821aab8609","local-member-id":"56c01ea8fdc90390","added-peer-id":"56c01ea8fdc90390","added-peer-peer-urls":["https://199.204.45.132:2380"]}
{"level":"info","ts":"2026-02-25T19:23:03.779461Z","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-02-25T19:23:03.779653Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.132:2380"}
{"level":"info","ts":"2026-02-25T19:23:03.779732Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.132:2380"}
{"level":"info","ts":"2026-02-25T19:23:03.779805Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"56c01ea8fdc90390","initial-advertise-peer-urls":["https://199.204.45.132:2380"],"listen-peer-urls":["https://199.204.45.132:2380"],"advertise-client-urls":["https://199.204.45.132:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.132:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-02-25T19:23:03.779928Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-02-25T19:23:03.95752Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 is starting a new election at term 1"}
{"level":"info","ts":"2026-02-25T19:23:03.95759Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 became pre-candidate at term 1"}
{"level":"info","ts":"2026-02-25T19:23:03.957639Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 received MsgPreVoteResp from 56c01ea8fdc90390 at term 1"}
{"level":"info","ts":"2026-02-25T19:23:03.95766Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 became candidate at term 2"}
{"level":"info","ts":"2026-02-25T19:23:03.95767Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 received MsgVoteResp from 56c01ea8fdc90390 at term 2"}
{"level":"info","ts":"2026-02-25T19:23:03.957686Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 became leader at term 2"}
{"level":"info","ts":"2026-02-25T19:23:03.9577Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 56c01ea8fdc90390 elected leader 56c01ea8fdc90390 at term 2"}
{"level":"info","ts":"2026-02-25T19:23:03.959736Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"56c01ea8fdc90390","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.132:2379]}","request-path":"/0/members/56c01ea8fdc90390/attributes","cluster-id":"c930fe821aab8609","publish-timeout":"7s"}
{"level":"info","ts":"2026-02-25T19:23:03.960229Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-02-25T19:23:03.960384Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-02-25T19:23:03.960522Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-25T19:23:03.960819Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-02-25T19:23:03.960961Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-02-25T19:23:03.962098Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-02-25T19:23:03.962198Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"c930fe821aab8609","local-member-id":"56c01ea8fdc90390","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-25T19:23:03.96242Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-25T19:23:03.962479Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-25T19:23:03.962486Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.132:2379"}
{"level":"info","ts":"2026-02-25T19:23:06.924181Z","caller":"traceutil/trace.go:171","msg":"trace[1507573061] linearizableReadLoop","detail":"{readStateIndex:75; appliedIndex:74; }","duration":"170.021756ms","start":"2026-02-25T19:23:06.754132Z","end":"2026-02-25T19:23:06.924153Z","steps":["trace[1507573061] 'read index received'  (duration: 169.788035ms)","trace[1507573061] 'applied index is now lower than readState.Index'  (duration: 232.651µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T19:23:06.924468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.288828ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:aggregate-to-admin\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-02-25T19:23:06.924546Z","caller":"traceutil/trace.go:171","msg":"trace[865724111] range","detail":"{range_begin:/registry/clusterroles/system:aggregate-to-admin; range_end:; response_count:0; response_revision:71; }","duration":"170.43312ms","start":"2026-02-25T19:23:06.7541Z","end":"2026-02-25T19:23:06.924533Z","steps":["trace[865724111] 'agreement among raft nodes before linearized reading'  (duration: 170.226799ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:23:06.924282Z","caller":"traceutil/trace.go:171","msg":"trace[15900902] transaction","detail":"{read_only:false; response_revision:71; number_of_response:1; }","duration":"171.076975ms","start":"2026-02-25T19:23:06.753186Z","end":"2026-02-25T19:23:06.924262Z","steps":["trace[15900902] 'process raft request'  (duration: 170.815843ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:23:07.430035Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":256877347913649369,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-02-25T19:23:07.885059Z","caller":"traceutil/trace.go:171","msg":"trace[1049806876] linearizableReadLoop","detail":"{readStateIndex:76; appliedIndex:75; }","duration":"955.2957ms","start":"2026-02-25T19:23:06.929731Z","end":"2026-02-25T19:23:07.885027Z","steps":["trace[1049806876] 'read index received'  (duration: 955.20765ms)","trace[1049806876] 'applied index is now lower than readState.Index'  (duration: 86.8µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T19:23:07.885211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"955.447972ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:aggregate-to-edit\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-02-25T19:23:07.885259Z","caller":"traceutil/trace.go:171","msg":"trace[311671925] range","detail":"{range_begin:/registry/clusterroles/system:aggregate-to-edit; range_end:; response_count:0; response_revision:72; }","duration":"955.531232ms","start":"2026-02-25T19:23:06.929712Z","end":"2026-02-25T19:23:07.885244Z","steps":["trace[311671925] 'agreement among raft nodes before linearized reading'  (duration: 955.418611ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:23:07.885327Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:23:06.929704Z","time spent":"955.611653ms","remote":"127.0.0.1:33562","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":0,"response size":27,"request content":"key:\"/registry/clusterroles/system:aggregate-to-edit\" "}
{"level":"info","ts":"2026-02-25T19:23:07.885505Z","caller":"traceutil/trace.go:171","msg":"trace[659463471] transaction","detail":"{read_only:false; response_revision:72; number_of_response:1; }","duration":"956.207827ms","start":"2026-02-25T19:23:06.929238Z","end":"2026-02-25T19:23:07.885446Z","steps":["trace[659463471] 'process raft request'  (duration: 955.651292ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:23:07.886268Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:23:06.929218Z","time spent":"956.365569ms","remote":"127.0.0.1:33578","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/priorityclasses/system-cluster-critical\" mod_revision:0 > success:<request_put:<key:\"/registry/priorityclasses/system-cluster-critical\" value_size:407 >> failure:<>"}
{"level":"warn","ts":"2026-02-25T19:23:08.4261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"420.729712ms","expected-duration":"100ms","prefix":"","request":"header:<ID:256877347913649377 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/clusterroles/cluster-admin\" mod_revision:0 > success:<request_put:<key:\"/registry/clusterroles/cluster-admin\" value_size:496 >> failure:<>>","response":"size:14"}
{"level":"info","ts":"2026-02-25T19:23:08.426205Z","caller":"traceutil/trace.go:171","msg":"trace[442251625] linearizableReadLoop","detail":"{readStateIndex:77; appliedIndex:76; }","duration":"446.714574ms","start":"2026-02-25T19:23:07.979474Z","end":"2026-02-25T19:23:08.426189Z","steps":["trace[442251625] 'read index received'  (duration: 25.63211ms)","trace[442251625] 'applied index is now lower than readState.Index'  (duration: 421.081274ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T19:23:08.42634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.130894ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:0 size:4"}
{"level":"warn","ts":"2026-02-25T19:23:08.426341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"446.871625ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-02-25T19:23:08.426379Z","caller":"traceutil/trace.go:171","msg":"trace[238618804] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:73; }","duration":"446.942926ms","start":"2026-02-25T19:23:07.979426Z","end":"2026-02-25T19:23:08.426369Z","steps":["trace[238618804] 'agreement among raft nodes before linearized reading'  (duration: 446.841095ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:23:08.426407Z","caller":"traceutil/trace.go:171","msg":"trace[1361748235] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:0; response_revision:73; }","duration":"276.216525ms","start":"2026-02-25T19:23:08.150145Z","end":"2026-02-25T19:23:08.426362Z","steps":["trace[1361748235] 'agreement among raft nodes before linearized reading'  (duration: 276.161184ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:23:08.426441Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:23:07.979411Z","time spent":"447.011656ms","remote":"127.0.0.1:33284","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-02-25T19:23:08.426241Z","caller":"traceutil/trace.go:171","msg":"trace[1243505645] transaction","detail":"{read_only:false; response_revision:73; number_of_response:1; }","duration":"527.204302ms","start":"2026-02-25T19:23:07.899017Z","end":"2026-02-25T19:23:08.426221Z","steps":["trace[1243505645] 'process raft request'  (duration: 106.136657ms)","trace[1243505645] 'compare'  (duration: 420.602091ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T19:23:08.426864Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:23:07.899003Z","time spent":"527.835917ms","remote":"127.0.0.1:33562","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/clusterroles/cluster-admin\" mod_revision:0 > success:<request_put:<key:\"/registry/clusterroles/cluster-admin\" value_size:496 >> failure:<>"}
{"level":"warn","ts":"2026-02-25T19:23:10.172131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.095125ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T19:23:10.172388Z","caller":"traceutil/trace.go:171","msg":"trace[1464976535] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:0; response_revision:248; }","duration":"103.424247ms","start":"2026-02-25T19:23:10.068934Z","end":"2026-02-25T19:23:10.172359Z","steps":["trace[1464976535] 'range keys from in-memory index tree'  (duration: 102.985693ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:23:10.172503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.681313ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3492"}
{"level":"info","ts":"2026-02-25T19:23:10.172685Z","caller":"traceutil/trace.go:171","msg":"trace[843599504] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:248; }","duration":"148.239237ms","start":"2026-02-25T19:23:10.024421Z","end":"2026-02-25T19:23:10.17266Z","steps":["trace[843599504] 'range keys from in-memory index tree'  (duration: 147.474082ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:23:26.455854Z","caller":"traceutil/trace.go:171","msg":"trace[1582137766] linearizableReadLoop","detail":"{readStateIndex:470; appliedIndex:469; }","duration":"147.238431ms","start":"2026-02-25T19:23:26.308586Z","end":"2026-02-25T19:23:26.455824Z","steps":["trace[1582137766] 'read index received'  (duration: 121.010681ms)","trace[1582137766] 'applied index is now lower than readState.Index'  (duration: 26.22642ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T19:23:26.455998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.395551ms","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-02-25T19:23:26.455974Z","caller":"traceutil/trace.go:171","msg":"trace[777924522] transaction","detail":"{read_only:false; response_revision:453; number_of_response:1; }","duration":"160.087199ms","start":"2026-02-25T19:23:26.295853Z","end":"2026-02-25T19:23:26.45594Z","steps":["trace[777924522] 'process raft request'  (duration: 133.82806ms)","trace[777924522] 'compare'  (duration: 26.013898ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T19:23:26.456037Z","caller":"traceutil/trace.go:171","msg":"trace[2016995615] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:453; }","duration":"147.496272ms","start":"2026-02-25T19:23:26.308529Z","end":"2026-02-25T19:23:26.456025Z","steps":["trace[2016995615] 'agreement among raft nodes before linearized reading'  (duration: 147.400211ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:23:36.89157Z","caller":"traceutil/trace.go:171","msg":"trace[1062607047] linearizableReadLoop","detail":"{readStateIndex:529; appliedIndex:528; }","duration":"493.167597ms","start":"2026-02-25T19:23:36.398374Z","end":"2026-02-25T19:23:36.891542Z","steps":["trace[1062607047] 'read index received'  (duration: 492.921595ms)","trace[1062607047] 'applied index is now lower than readState.Index'  (duration: 244.792µs)"],"step_count":2}
{"level":"info","ts":"2026-02-25T19:23:36.891638Z","caller":"traceutil/trace.go:171","msg":"trace[1412521652] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"568.420749ms","start":"2026-02-25T19:23:36.323173Z","end":"2026-02-25T19:23:36.891594Z","steps":["trace[1412521652] 'process raft request'  (duration: 568.168948ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:23:36.891726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"493.335538ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4375"}
{"level":"info","ts":"2026-02-25T19:23:36.891813Z","caller":"traceutil/trace.go:171","msg":"trace[23256490] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:510; }","duration":"493.46753ms","start":"2026-02-25T19:23:36.398332Z","end":"2026-02-25T19:23:36.891799Z","steps":["trace[23256490] 'agreement among raft nodes before linearized reading'  (duration: 493.332788ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:23:36.891897Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:23:36.398315Z","time spent":"493.53399ms","remote":"127.0.0.1:33418","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":4398,"request content":"key:\"/registry/minions/instance\" "}
{"level":"warn","ts":"2026-02-25T19:23:36.892026Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:23:36.323162Z","time spent":"568.54465ms","remote":"127.0.0.1:33500","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:471 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-02-25T19:23:36.921858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"381.825336ms","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-02-25T19:23:36.921889Z","caller":"traceutil/trace.go:171","msg":"trace[853335019] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"354.548546ms","start":"2026-02-25T19:23:36.567311Z","end":"2026-02-25T19:23:36.92186Z","steps":["trace[853335019] 'process raft request'  (duration: 354.288604ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:23:36.921954Z","caller":"traceutil/trace.go:171","msg":"trace[808133685] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:511; }","duration":"381.980136ms","start":"2026-02-25T19:23:36.539958Z","end":"2026-02-25T19:23:36.921938Z","steps":["trace[808133685] 'agreement among raft nodes before linearized reading'  (duration: 381.785065ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:23:36.921991Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:23:36.539934Z","time spent":"382.048207ms","remote":"127.0.0.1:33500","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-02-25T19:23:36.922073Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:23:36.567301Z","time spent":"354.658596ms","remote":"127.0.0.1:33500","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:453 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"warn","ts":"2026-02-25T19:23:36.922047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.372844ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"info","ts":"2026-02-25T19:23:36.922155Z","caller":"traceutil/trace.go:171","msg":"trace[946077260] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:511; }","duration":"270.511165ms","start":"2026-02-25T19:23:36.651624Z","end":"2026-02-25T19:23:36.922135Z","steps":["trace[946077260] 'agreement among raft nodes before linearized reading'  (duration: 270.285413ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:23:43.984255Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":256877347913650362,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-02-25T19:23:44.062838Z","caller":"traceutil/trace.go:171","msg":"trace[1173807190] linearizableReadLoop","detail":"{readStateIndex:574; appliedIndex:573; }","duration":"579.651497ms","start":"2026-02-25T19:23:43.483169Z","end":"2026-02-25T19:23:44.062821Z","steps":["trace[1173807190] 'read index received'  (duration: 579.589524ms)","trace[1173807190] 'applied index is now lower than readState.Index'  (duration: 61.233µs)"],"step_count":2}
{"level":"info","ts":"2026-02-25T19:23:44.062927Z","caller":"traceutil/trace.go:171","msg":"trace[1769317069] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"770.275792ms","start":"2026-02-25T19:23:43.292628Z","end":"2026-02-25T19:23:44.062904Z","steps":["trace[1769317069] 'process raft request'  (duration: 770.051191ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:23:44.062994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"579.811074ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-02-25T19:23:44.063017Z","caller":"traceutil/trace.go:171","msg":"trace[730885755] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:554; }","duration":"579.888338ms","start":"2026-02-25T19:23:43.483123Z","end":"2026-02-25T19:23:44.063012Z","steps":["trace[730885755] 'agreement among raft nodes before linearized reading'  (duration: 579.790863ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:23:44.063034Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:23:43.2926Z","time spent":"770.378487ms","remote":"127.0.0.1:33430","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-h784c\" mod_revision:499 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-h784c\" value_size:17085 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-h784c\" > >"}
{"level":"warn","ts":"2026-02-25T19:23:44.063041Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:23:43.483102Z","time spent":"579.93437ms","remote":"127.0.0.1:33500","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-02-25T19:23:45.430202Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":256877347913650366,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-25T19:23:45.930756Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":256877347913650366,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-25T19:23:46.430911Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":256877347913650366,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-25T19:23:46.931943Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":256877347913650366,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-25T19:23:47.245067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000309748s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-02-25T19:23:47.245256Z","caller":"traceutil/trace.go:171","msg":"trace[965526648] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000584891s","start":"2026-02-25T19:23:45.244639Z","end":"2026-02-25T19:23:47.245224Z","steps":["trace[965526648] 'agreement among raft nodes before linearized reading'  (duration: 2.00033439s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:23:47.245324Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:23:45.244615Z","time spent":"2.000696286s","remote":"127.0.0.1:33284","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
2026/02/25 19:23:47 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-02-25T19:23:47.432642Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":256877347913650366,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-25T19:23:47.933457Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":256877347913650366,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-25T19:23:47.946139Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"3.58012019s","expected-duration":"1s"}
{"level":"warn","ts":"2026-02-25T19:23:48.012631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000417497s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-02-25T19:23:48.012825Z","caller":"traceutil/trace.go:171","msg":"trace[174211694] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.00071464s","start":"2026-02-25T19:23:46.012062Z","end":"2026-02-25T19:23:48.012777Z","steps":["trace[174211694] 'agreement among raft nodes before linearized reading'  (duration: 2.000428587s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:23:48.012909Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:23:46.012045Z","time spent":"2.000846636s","remote":"127.0.0.1:33290","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
2026/02/25 19:23:48 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-02-25T19:23:48.083485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:23:44.806589Z","time spent":"3.276881017s","remote":"127.0.0.1:43180","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"warn","ts":"2026-02-25T19:23:48.084738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.842428022s","expected-duration":"100ms","prefix":"","request":"header:<ID:256877347913650367 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:546 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-25T19:23:48.085031Z","caller":"traceutil/trace.go:171","msg":"trace[1433126129] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"4.016499958s","start":"2026-02-25T19:23:44.068504Z","end":"2026-02-25T19:23:48.085004Z","steps":["trace[1433126129] 'process raft request'  (duration: 173.759992ms)","trace[1433126129] 'compare'  (duration: 3.841162533s)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T19:23:48.085161Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:23:44.068485Z","time spent":"4.016612903s","remote":"127.0.0.1:33500","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:546 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-02-25T19:23:48.306862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.064108ms","expected-duration":"100ms","prefix":"","request":"header:<ID:256877347913650368 > lease_revoke:<id:03909c96413ccffc>","response":"size:28"}
{"level":"info","ts":"2026-02-25T19:23:48.307987Z","caller":"traceutil/trace.go:171","msg":"trace[1002380088] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"1.262018148s","start":"2026-02-25T19:23:47.045936Z","end":"2026-02-25T19:23:48.307954Z","steps":["trace[1002380088] 'process raft request'  (duration: 1.261027881s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:23:48.308174Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:23:47.04591Z","time spent":"1.262160894s","remote":"127.0.0.1:33500","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:511 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:599 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"warn","ts":"2026-02-25T19:23:49.929186Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.999584297s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-02-25T19:23:49.929251Z","caller":"traceutil/trace.go:171","msg":"trace[1864088720] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; }","duration":"4.999698582s","start":"2026-02-25T19:23:44.929534Z","end":"2026-02-25T19:23:49.929233Z","steps":["trace[1864088720] 'agreement among raft nodes before linearized reading'  (duration: 4.999620999s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:23:49.929286Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:23:44.929514Z","time spent":"4.999765375s","remote":"127.0.0.1:33500","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/02/25 19:23:49 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-02-25T19:23:49.978015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.999925765s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-02-25T19:23:49.978141Z","caller":"traceutil/trace.go:171","msg":"trace[1023149395] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; }","duration":"5.000129224s","start":"2026-02-25T19:23:44.977982Z","end":"2026-02-25T19:23:49.978111Z","steps":["trace[1023149395] 'agreement among raft nodes before linearized reading'  (duration: 4.999937635s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:23:49.978209Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:23:44.977973Z","time spent":"5.000223278s","remote":"127.0.0.1:33500","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/02/25 19:23:49 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-02-25T19:23:50.021043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999625524s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-02-25T19:23:50.02114Z","caller":"traceutil/trace.go:171","msg":"trace[1211697268] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"1.999792302s","start":"2026-02-25T19:23:48.021327Z","end":"2026-02-25T19:23:50.021119Z","steps":["trace[1211697268] 'agreement among raft nodes before linearized reading'  (duration: 1.999672877s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:23:50.021204Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:23:48.021292Z","time spent":"1.999901757s","remote":"127.0.0.1:33284","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
2026/02/25 19:23:50 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-02-25T19:23:52.021303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999948613s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-02-25T19:23:52.021392Z","caller":"traceutil/trace.go:171","msg":"trace[1914663234] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000082529s","start":"2026-02-25T19:23:50.021291Z","end":"2026-02-25T19:23:52.021374Z","steps":["trace[1914663234] 'agreement among raft nodes before linearized reading'  (duration: 1.999971684s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:23:52.02144Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:23:50.021278Z","time spent":"2.000152542s","remote":"127.0.0.1:33290","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-02-25T19:23:53.256847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.94882373s","expected-duration":"100ms","prefix":"","request":"header:<ID:256877347913650370 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/kube-system/kube-apiserver-instance.189793bf1224c67f\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/kube-apiserver-instance.189793bf1224c67f\" value_size:671 lease:256877347913649657 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-02-25T19:23:53.256977Z","caller":"traceutil/trace.go:171","msg":"trace[383808542] linearizableReadLoop","detail":"{readStateIndex:578; appliedIndex:574; }","duration":"8.327377402s","start":"2026-02-25T19:23:44.92958Z","end":"2026-02-25T19:23:53.256957Z","steps":["trace[383808542] 'read index received'  (duration: 3.016909617s)","trace[383808542] 'applied index is now lower than readState.Index'  (duration: 5.310466355s)"],"step_count":2}
{"level":"info","ts":"2026-02-25T19:23:53.25704Z","caller":"traceutil/trace.go:171","msg":"trace[1928311282] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"6.008305749s","start":"2026-02-25T19:23:47.248724Z","end":"2026-02-25T19:23:53.257029Z","steps":["trace[1928311282] 'process raft request'  (duration: 1.059206107s)","trace[1928311282] 'compare'  (duration: 4.948726935s)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T19:23:53.257088Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:23:47.248698Z","time spent":"6.008365441s","remote":"127.0.0.1:33356","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":758,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/kube-apiserver-instance.189793bf1224c67f\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/kube-apiserver-instance.189793bf1224c67f\" value_size:671 lease:256877347913649657 >> failure:<>"}
{"level":"warn","ts":"2026-02-25T19:23:53.370816Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.250626235s","expected-duration":"1s"}
{"level":"warn","ts":"2026-02-25T19:23:53.796828Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.62936ms","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-02-25T19:23:53.796911Z","caller":"traceutil/trace.go:171","msg":"trace[1854185354] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:557; }","duration":"177.726485ms","start":"2026-02-25T19:23:53.619172Z","end":"2026-02-25T19:23:53.796899Z","steps":["trace[1854185354] 'range keys from in-memory index tree'  (duration: 177.61683ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:23:53.797483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"426.387176ms","expected-duration":"100ms","prefix":"","request":"header:<ID:256877347913650371 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:547 > 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-02-25T19:23:53.797668Z","caller":"traceutil/trace.go:171","msg":"trace[250538280] transaction","detail":"{read_only:false; response_revision:559; number_of_response:1; }","duration":"536.634426ms","start":"2026-02-25T19:23:53.261015Z","end":"2026-02-25T19:23:53.797649Z","steps":["trace[250538280] 'process raft request'  (duration: 536.562093ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:23:53.797743Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:23:53.261Z","time spent":"536.71087ms","remote":"127.0.0.1:33356","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":759,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/kube-apiserver-instance.189793bf3fe94c2f\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/kube-apiserver-instance.189793bf3fe94c2f\" value_size:672 lease:256877347913649657 >> failure:<>"}
{"level":"info","ts":"2026-02-25T19:23:53.798161Z","caller":"traceutil/trace.go:171","msg":"trace[141555668] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"1.678041095s","start":"2026-02-25T19:23:52.120106Z","end":"2026-02-25T19:23:53.798147Z","steps":["trace[141555668] 'process raft request'  (duration: 1.250920127s)","trace[141555668] 'compare'  (duration: 425.771639ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T19:23:53.798253Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:23:52.120087Z","time spent":"1.678121228s","remote":"127.0.0.1:33500","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:547 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:471 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"info","ts":"2026-02-25T19:23:53.798434Z","caller":"traceutil/trace.go:171","msg":"trace[127297867] linearizableReadLoop","detail":"{readStateIndex:579; appliedIndex:578; }","duration":"541.420626ms","start":"2026-02-25T19:23:53.257002Z","end":"2026-02-25T19:23:53.798423Z","steps":["trace[127297867] 'read index received'  (duration: 114.032717ms)","trace[127297867] 'applied index is now lower than readState.Index'  (duration: 427.386849ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T19:23:53.798579Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"8.823874493s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"info","ts":"2026-02-25T19:23:53.798623Z","caller":"traceutil/trace.go:171","msg":"trace[1204732923] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:559; }","duration":"8.823954746s","start":"2026-02-25T19:23:44.974656Z","end":"2026-02-25T19:23:53.79861Z","steps":["trace[1204732923] 'agreement among raft nodes before linearized reading'  (duration: 8.823809889s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:23:53.798661Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:23:44.974636Z","time spent":"8.824015258s","remote":"127.0.0.1:33500","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-02-25T19:23:53.798875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.771195569s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T19:23:53.79892Z","caller":"traceutil/trace.go:171","msg":"trace[1827078214] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:559; }","duration":"1.771263831s","start":"2026-02-25T19:23:52.027642Z","end":"2026-02-25T19:23:53.798906Z","steps":["trace[1827078214] 'agreement among raft nodes before linearized reading'  (duration: 1.771208999s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:23:53.798957Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:23:52.027622Z","time spent":"1.771326154s","remote":"127.0.0.1:33284","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-25T19:23:53.799195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.818943808s","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-02-25T19:23:53.799253Z","caller":"traceutil/trace.go:171","msg":"trace[230088756] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:559; }","duration":"1.819035013s","start":"2026-02-25T19:23:51.980207Z","end":"2026-02-25T19:23:53.799242Z","steps":["trace[230088756] 'agreement among raft nodes before linearized reading'  (duration: 1.818898567s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:23:53.799283Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:23:51.980176Z","time spent":"1.819099626s","remote":"127.0.0.1:33500","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-02-25T19:23:53.799462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.868718803s","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-02-25T19:23:53.799496Z","caller":"traceutil/trace.go:171","msg":"trace[1597120824] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:559; }","duration":"1.868788185s","start":"2026-02-25T19:23:51.930698Z","end":"2026-02-25T19:23:53.799486Z","steps":["trace[1597120824] 'agreement among raft nodes before linearized reading'  (duration: 1.868702772s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:23:53.799524Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:23:51.930678Z","time spent":"1.868838918s","remote":"127.0.0.1:33500","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-02-25T19:23:53.799744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.710428475s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-02-25T19:23:53.799793Z","caller":"traceutil/trace.go:171","msg":"trace[1373216324] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:559; }","duration":"3.710515809s","start":"2026-02-25T19:23:50.089258Z","end":"2026-02-25T19:23:53.799774Z","steps":["trace[1373216324] 'agreement among raft nodes before linearized reading'  (duration: 3.710416105s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:23:53.799845Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:23:50.089207Z","time spent":"3.710623905s","remote":"127.0.0.1:33500","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-02-25T19:23:53.80004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.535444662s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.132\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-02-25T19:23:53.800088Z","caller":"traceutil/trace.go:171","msg":"trace[1570614903] range","detail":"{range_begin:/registry/masterleases/199.204.45.132; range_end:; response_count:1; response_revision:559; }","duration":"4.535544197s","start":"2026-02-25T19:23:49.264528Z","end":"2026-02-25T19:23:53.800072Z","steps":["trace[1570614903] 'agreement among raft nodes before linearized reading'  (duration: 4.535471484s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:23:53.800141Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:23:49.264494Z","time spent":"4.53563303s","remote":"127.0.0.1:33306","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.204.45.132\" "}
{"level":"warn","ts":"2026-02-25T19:23:54.434708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.040737ms","expected-duration":"100ms","prefix":"","request":"header:<ID:256877347913650378 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:555 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-25T19:23:54.434877Z","caller":"traceutil/trace.go:171","msg":"trace[1865630539] transaction","detail":"{read_only:false; response_revision:560; number_of_response:1; }","duration":"630.375186ms","start":"2026-02-25T19:23:53.80448Z","end":"2026-02-25T19:23:54.434855Z","steps":["trace[1865630539] 'process raft request'  (duration: 465.111719ms)","trace[1865630539] 'compare'  (duration: 164.902592ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T19:23:54.434947Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:23:53.804465Z","time spent":"630.4557ms","remote":"127.0.0.1:33500","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:555 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-02-25T19:23:54.435291Z","caller":"traceutil/trace.go:171","msg":"trace[1652500879] transaction","detail":"{read_only:false; response_revision:564; number_of_response:1; }","duration":"570.047763ms","start":"2026-02-25T19:23:53.865236Z","end":"2026-02-25T19:23:54.435284Z","steps":["trace[1652500879] 'process raft request'  (duration: 569.655417ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:23:54.435319Z","caller":"traceutil/trace.go:171","msg":"trace[1190940924] transaction","detail":"{read_only:false; response_revision:561; number_of_response:1; }","duration":"629.932527ms","start":"2026-02-25T19:23:53.805381Z","end":"2026-02-25T19:23:54.435313Z","steps":["trace[1190940924] 'process raft request'  (duration: 629.415804ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:23:54.435341Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:23:53.865221Z","time spent":"570.094636ms","remote":"127.0.0.1:33306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/masterleases/199.204.45.132\" mod_revision:519 > success:<request_put:<key:\"/registry/masterleases/199.204.45.132\" value_size:67 lease:256877347913650376 >> failure:<request_range:<key:\"/registry/masterleases/199.204.45.132\" > >"}
{"level":"info","ts":"2026-02-25T19:23:54.435325Z","caller":"traceutil/trace.go:171","msg":"trace[953769526] transaction","detail":"{read_only:false; response_revision:565; number_of_response:1; }","duration":"568.947965ms","start":"2026-02-25T19:23:53.866347Z","end":"2026-02-25T19:23:54.435295Z","steps":["trace[953769526] 'process raft request'  (duration: 568.575719ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:23:54.435375Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:23:53.80537Z","time spent":"629.967568ms","remote":"127.0.0.1:33500","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:553 > 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-02-25T19:23:54.435377Z","caller":"traceutil/trace.go:171","msg":"trace[1829671275] transaction","detail":"{read_only:false; response_revision:562; number_of_response:1; }","duration":"629.876834ms","start":"2026-02-25T19:23:53.805474Z","end":"2026-02-25T19:23:54.435351Z","steps":["trace[1829671275] 'process raft request'  (duration: 629.363302ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:23:54.435288Z","caller":"traceutil/trace.go:171","msg":"trace[1845761518] transaction","detail":"{read_only:false; response_revision:563; number_of_response:1; }","duration":"628.384529ms","start":"2026-02-25T19:23:53.806891Z","end":"2026-02-25T19:23:54.435275Z","steps":["trace[1845761518] 'process raft request'  (duration: 627.969071ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:23:54.435416Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:23:53.866333Z","time spent":"569.034939ms","remote":"127.0.0.1:33356","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":759,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/kube-apiserver-instance.189793bf3fe94c2f\" mod_revision:559 > success:<request_put:<key:\"/registry/events/kube-system/kube-apiserver-instance.189793bf3fe94c2f\" value_size:672 lease:256877347913649657 >> failure:<request_range:<key:\"/registry/events/kube-system/kube-apiserver-instance.189793bf3fe94c2f\" > >"}
{"level":"warn","ts":"2026-02-25T19:23:54.4355Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:23:53.805454Z","time spent":"629.977619ms","remote":"127.0.0.1:33500","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:551 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-02-25T19:23:54.435528Z","caller":"traceutil/trace.go:171","msg":"trace[963770853] linearizableReadLoop","detail":"{readStateIndex:585; appliedIndex:581; }","duration":"571.701285ms","start":"2026-02-25T19:23:53.863817Z","end":"2026-02-25T19:23:54.435518Z","steps":["trace[963770853] 'read index received'  (duration: 405.77057ms)","trace[963770853] 'applied index is now lower than readState.Index'  (duration: 165.928575ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T19:23:54.435744Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:23:53.80688Z","time spent":"628.577667ms","remote":"127.0.0.1:33500","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:552 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-02-25T19:23:54.452378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"642.852152ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T19:23:54.452447Z","caller":"traceutil/trace.go:171","msg":"trace[1777117071] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:565; }","duration":"642.960357ms","start":"2026-02-25T19:23:53.80947Z","end":"2026-02-25T19:23:54.452431Z","steps":["trace[1777117071] 'agreement among raft nodes before linearized reading'  (duration: 626.078109ms)","trace[1777117071] 'range keys from in-memory index tree'  (duration: 16.773253ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T19:23:54.452477Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:23:53.809461Z","time spent":"643.009458ms","remote":"127.0.0.1:33284","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-02-25T19:23:55.476879Z","caller":"traceutil/trace.go:171","msg":"trace[375212920] transaction","detail":"{read_only:false; response_revision:566; number_of_response:1; }","duration":"167.933217ms","start":"2026-02-25T19:23:55.308922Z","end":"2026-02-25T19:23:55.476856Z","steps":["trace[375212920] 'process raft request'  (duration: 167.796111ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:23:55.755979Z","caller":"traceutil/trace.go:171","msg":"trace[2117500927] transaction","detail":"{read_only:false; response_revision:567; number_of_response:1; }","duration":"435.923258ms","start":"2026-02-25T19:23:55.320029Z","end":"2026-02-25T19:23:55.755952Z","steps":["trace[2117500927] 'process raft request'  (duration: 435.296601ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:23:55.756347Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:23:55.320001Z","time spent":"436.276743ms","remote":"127.0.0.1:33430","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17232,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-h784c\" mod_revision:554 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-h784c\" value_size:17183 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-h784c\" > >"}
{"level":"info","ts":"2026-02-25T19:23:56.578651Z","caller":"traceutil/trace.go:171","msg":"trace[397716539] transaction","detail":"{read_only:false; response_revision:568; number_of_response:1; }","duration":"136.102993ms","start":"2026-02-25T19:23:56.442525Z","end":"2026-02-25T19:23:56.578628Z","steps":["trace[397716539] 'process raft request'  (duration: 135.966797ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:23:56.881988Z","caller":"traceutil/trace.go:171","msg":"trace[751614210] transaction","detail":"{read_only:false; response_revision:569; number_of_response:1; }","duration":"438.831814ms","start":"2026-02-25T19:23:56.443107Z","end":"2026-02-25T19:23:56.881939Z","steps":["trace[751614210] 'process raft request'  (duration: 344.066502ms)","trace[751614210] 'compare'  (duration: 94.610575ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T19:23:56.882125Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:23:56.44309Z","time spent":"438.96693ms","remote":"127.0.0.1:33500","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:563 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-02-25T19:23:56.882216Z","caller":"traceutil/trace.go:171","msg":"trace[1177016582] transaction","detail":"{read_only:false; response_revision:570; number_of_response:1; }","duration":"438.72365ms","start":"2026-02-25T19:23:56.443473Z","end":"2026-02-25T19:23:56.882197Z","steps":["trace[1177016582] 'process raft request'  (duration: 438.426137ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:23:56.882347Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:23:56.443427Z","time spent":"438.853095ms","remote":"127.0.0.1:33500","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:562 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-02-25T19:23:56.882322Z","caller":"traceutil/trace.go:171","msg":"trace[75102731] transaction","detail":"{read_only:false; response_revision:571; number_of_response:1; }","duration":"438.01511ms","start":"2026-02-25T19:23:56.444281Z","end":"2026-02-25T19:23:56.882297Z","steps":["trace[75102731] 'process raft request'  (duration: 437.820442ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:23:56.88247Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:23:56.444272Z","time spent":"438.128354ms","remote":"127.0.0.1:33500","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:560 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-02-25T19:23:58.793768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.491333ms","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-02-25T19:23:58.793828Z","caller":"traceutil/trace.go:171","msg":"trace[1691872329] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:573; }","duration":"211.599308ms","start":"2026-02-25T19:23:58.582214Z","end":"2026-02-25T19:23:58.793813Z","steps":["trace[1691872329] 'range keys from in-memory index tree'  (duration: 211.281995ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:23:58.793937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.073575ms","expected-duration":"100ms","prefix":"","request":"header:<ID:256877347913650408 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:556 > 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-02-25T19:23:58.794049Z","caller":"traceutil/trace.go:171","msg":"trace[897360322] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"181.301821ms","start":"2026-02-25T19:23:58.612727Z","end":"2026-02-25T19:23:58.794029Z","steps":["trace[897360322] 'process raft request'  (duration: 66.032898ms)","trace[897360322] 'compare'  (duration: 114.938469ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T19:23:59.082792Z","caller":"traceutil/trace.go:171","msg":"trace[893168525] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"188.301622ms","start":"2026-02-25T19:23:58.89446Z","end":"2026-02-25T19:23:59.082761Z","steps":["trace[893168525] 'process raft request'  (duration: 172.376854ms)","trace[893168525] 'compare'  (duration: 15.773771ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T19:23:59.08298Z","caller":"traceutil/trace.go:171","msg":"trace[53959271] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"187.678486ms","start":"2026-02-25T19:23:58.895292Z","end":"2026-02-25T19:23:59.082971Z","steps":["trace[53959271] 'process raft request'  (duration: 187.433156ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:24:00.733188Z","caller":"traceutil/trace.go:171","msg":"trace[1611778017] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"119.898992ms","start":"2026-02-25T19:24:00.613265Z","end":"2026-02-25T19:24:00.733164Z","steps":["trace[1611778017] 'process raft request'  (duration: 119.769997ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:24:04.666064Z","caller":"traceutil/trace.go:171","msg":"trace[1012697471] transaction","detail":"{read_only:false; response_revision:668; number_of_response:1; }","duration":"263.794123ms","start":"2026-02-25T19:24:04.402241Z","end":"2026-02-25T19:24:04.666035Z","steps":["trace[1012697471] 'process raft request'  (duration: 263.612096ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:24:04.666737Z","caller":"traceutil/trace.go:171","msg":"trace[1434945640] linearizableReadLoop","detail":"{readStateIndex:692; appliedIndex:692; }","duration":"256.027674ms","start":"2026-02-25T19:24:04.410701Z","end":"2026-02-25T19:24:04.666729Z","steps":["trace[1434945640] 'read index received'  (duration: 256.023634ms)","trace[1434945640] 'applied index is now lower than readState.Index'  (duration: 3.67µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T19:24:04.666999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.265223ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io\" ","response":"range_response_count:1 size:4180"}
{"level":"info","ts":"2026-02-25T19:24:04.667031Z","caller":"traceutil/trace.go:171","msg":"trace[1363084877] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io; range_end:; response_count:1; response_revision:668; }","duration":"256.363427ms","start":"2026-02-25T19:24:04.410659Z","end":"2026-02-25T19:24:04.667022Z","steps":["trace[1363084877] 'agreement among raft nodes before linearized reading'  (duration: 256.123027ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:24:04.722351Z","caller":"traceutil/trace.go:171","msg":"trace[1601234918] transaction","detail":"{read_only:false; response_revision:669; number_of_response:1; }","duration":"261.88976ms","start":"2026-02-25T19:24:04.460429Z","end":"2026-02-25T19:24:04.722319Z","steps":["trace[1601234918] 'process raft request'  (duration: 261.574868ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:24:04.819958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"371.174468ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/coredns\" ","response":"range_response_count:1 size:179"}
{"level":"warn","ts":"2026-02-25T19:24:04.820105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"371.388266ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/coredns\" ","response":"range_response_count:1 size:179"}
{"level":"info","ts":"2026-02-25T19:24:04.820219Z","caller":"traceutil/trace.go:171","msg":"trace[587396379] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/coredns; range_end:; response_count:1; response_revision:669; }","duration":"371.470169ms","start":"2026-02-25T19:24:04.448689Z","end":"2026-02-25T19:24:04.82016Z","steps":["trace[587396379] 'agreement among raft nodes before linearized reading'  (duration: 274.246144ms)","trace[587396379] 'range keys from in-memory index tree'  (duration: 97.123511ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T19:24:04.820263Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:24:04.448681Z","time spent":"371.572723ms","remote":"127.0.0.1:33446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":202,"request content":"key:\"/registry/serviceaccounts/kube-system/coredns\" "}
{"level":"warn","ts":"2026-02-25T19:24:04.820176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"372.088263ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/coredns\" ","response":"range_response_count:1 size:179"}
{"level":"warn","ts":"2026-02-25T19:24:04.820345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.861023ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" ","response":"range_response_count:1 size:188252"}
{"level":"info","ts":"2026-02-25T19:24:04.820425Z","caller":"traceutil/trace.go:171","msg":"trace[795062755] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/coredns; range_end:; response_count:1; response_revision:669; }","duration":"372.389644ms","start":"2026-02-25T19:24:04.448007Z","end":"2026-02-25T19:24:04.820396Z","steps":["trace[795062755] 'agreement among raft nodes before linearized reading'  (duration: 274.860808ms)","trace[795062755] 'range keys from in-memory index tree'  (duration: 97.159803ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T19:24:04.820479Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:24:04.447987Z","time spent":"372.479538ms","remote":"127.0.0.1:33446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":202,"request content":"key:\"/registry/serviceaccounts/kube-system/coredns\" "}
{"level":"info","ts":"2026-02-25T19:24:04.820509Z","caller":"traceutil/trace.go:171","msg":"trace[35445260] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io; range_end:; response_count:1; response_revision:669; }","duration":"209.102082ms","start":"2026-02-25T19:24:04.611349Z","end":"2026-02-25T19:24:04.820451Z","steps":["trace[35445260] 'agreement among raft nodes before linearized reading'  (duration: 111.594707ms)","trace[35445260] 'range keys from in-memory index tree'  (duration: 96.929243ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T19:24:04.820615Z","caller":"traceutil/trace.go:171","msg":"trace[749502056] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/coredns; range_end:; response_count:1; response_revision:669; }","duration":"371.858424ms","start":"2026-02-25T19:24:04.44874Z","end":"2026-02-25T19:24:04.820598Z","steps":["trace[749502056] 'agreement among raft nodes before linearized reading'  (duration: 274.183672ms)","trace[749502056] 'range keys from in-memory index tree'  (duration: 96.968815ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T19:24:04.820406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"371.21616ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/local-path-storage/local-path-provisioner\" ","response":"range_response_count:1 size:897"}
{"level":"info","ts":"2026-02-25T19:24:04.820859Z","caller":"traceutil/trace.go:171","msg":"trace[787893347] range","detail":"{range_begin:/registry/serviceaccounts/local-path-storage/local-path-provisioner; range_end:; response_count:1; response_revision:669; }","duration":"371.967718ms","start":"2026-02-25T19:24:04.448792Z","end":"2026-02-25T19:24:04.82076Z","steps":["trace[787893347] 'agreement among raft nodes before linearized reading'  (duration: 274.12898ms)","trace[787893347] 'range keys from in-memory index tree'  (duration: 97.052499ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T19:24:04.820662Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:24:04.448733Z","time spent":"371.918636ms","remote":"127.0.0.1:33446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":202,"request content":"key:\"/registry/serviceaccounts/kube-system/coredns\" "}
{"level":"warn","ts":"2026-02-25T19:24:04.821009Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:24:04.448771Z","time spent":"372.157185ms","remote":"127.0.0.1:33446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":1,"response size":920,"request content":"key:\"/registry/serviceaccounts/local-path-storage/local-path-provisioner\" "}
{"level":"warn","ts":"2026-02-25T19:24:05.083506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.000754ms","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-02-25T19:24:05.083559Z","caller":"traceutil/trace.go:171","msg":"trace[1427639366] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:671; }","duration":"139.080146ms","start":"2026-02-25T19:24:04.944466Z","end":"2026-02-25T19:24:05.083546Z","steps":["trace[1427639366] 'range keys from in-memory index tree'  (duration: 138.837647ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:24:15.276125Z","caller":"traceutil/trace.go:171","msg":"trace[2106746418] transaction","detail":"{read_only:false; response_revision:765; number_of_response:1; }","duration":"122.552439ms","start":"2026-02-25T19:24:15.153549Z","end":"2026-02-25T19:24:15.276101Z","steps":["trace[2106746418] 'process raft request'  (duration: 122.216627ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:24:45.44208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.897245ms","expected-duration":"100ms","prefix":"","request":"header:<ID:256877347913651039 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:847 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-25T19:24:45.442471Z","caller":"traceutil/trace.go:171","msg":"trace[1893780028] transaction","detail":"{read_only:false; response_revision:854; number_of_response:1; }","duration":"115.549481ms","start":"2026-02-25T19:24:45.326901Z","end":"2026-02-25T19:24:45.442451Z","steps":["trace[1893780028] 'process raft request'  (duration: 11.202234ms)","trace[1893780028] 'compare'  (duration: 103.654839ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T19:24:48.643579Z","caller":"traceutil/trace.go:171","msg":"trace[754763252] transaction","detail":"{read_only:false; response_revision:861; number_of_response:1; }","duration":"144.479574ms","start":"2026-02-25T19:24:48.49908Z","end":"2026-02-25T19:24:48.643559Z","steps":["trace[754763252] 'process raft request'  (duration: 144.369401ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:24:49.166734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.907153ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T19:24:49.16679Z","caller":"traceutil/trace.go:171","msg":"trace[1552356741] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:861; }","duration":"154.024186ms","start":"2026-02-25T19:24:49.012754Z","end":"2026-02-25T19:24:49.166779Z","steps":["trace[1552356741] 'range keys from in-memory index tree'  (duration: 153.810991ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:24:49.646698Z","caller":"traceutil/trace.go:171","msg":"trace[1661996419] transaction","detail":"{read_only:false; response_revision:866; number_of_response:1; }","duration":"127.906489ms","start":"2026-02-25T19:24:49.518757Z","end":"2026-02-25T19:24:49.646664Z","steps":["trace[1661996419] 'process raft request'  (duration: 99.770363ms)","trace[1661996419] 'compare'  (duration: 28.017903ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T19:25:09.807531Z","caller":"traceutil/trace.go:171","msg":"trace[1098133313] transaction","detail":"{read_only:false; response_revision:952; number_of_response:1; }","duration":"197.010471ms","start":"2026-02-25T19:25:09.610368Z","end":"2026-02-25T19:25:09.807378Z","steps":["trace[1098133313] 'process raft request'  (duration: 196.620533ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:25:09.807714Z","caller":"traceutil/trace.go:171","msg":"trace[391361436] linearizableReadLoop","detail":"{readStateIndex:994; appliedIndex:993; }","duration":"183.446519ms","start":"2026-02-25T19:25:09.624257Z","end":"2026-02-25T19:25:09.807703Z","steps":["trace[391361436] 'read index received'  (duration: 182.774416ms)","trace[391361436] 'applied index is now lower than readState.Index'  (duration: 130.152µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T19:25:09.807957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.690114ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"info","ts":"2026-02-25T19:25:09.808012Z","caller":"traceutil/trace.go:171","msg":"trace[650749208] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:952; }","duration":"183.797576ms","start":"2026-02-25T19:25:09.624202Z","end":"2026-02-25T19:25:09.808Z","steps":["trace[650749208] 'agreement among raft nodes before linearized reading'  (duration: 182.965009ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:25:18.235666Z","caller":"traceutil/trace.go:171","msg":"trace[1637668753] linearizableReadLoop","detail":"{readStateIndex:1025; appliedIndex:1024; }","duration":"380.422111ms","start":"2026-02-25T19:25:17.855211Z","end":"2026-02-25T19:25:18.235633Z","steps":["trace[1637668753] 'read index received'  (duration: 380.073674ms)","trace[1637668753] 'applied index is now lower than readState.Index'  (duration: 347.287µs)"],"step_count":2}
{"level":"info","ts":"2026-02-25T19:25:18.235822Z","caller":"traceutil/trace.go:171","msg":"trace[2021788121] transaction","detail":"{read_only:false; response_revision:981; number_of_response:1; }","duration":"390.327945ms","start":"2026-02-25T19:25:17.845483Z","end":"2026-02-25T19:25:18.23581Z","steps":["trace[2021788121] 'process raft request'  (duration: 389.874207ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:25:18.236024Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:25:17.845453Z","time spent":"390.400706ms","remote":"127.0.0.1:33500","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:974 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-02-25T19:25:18.236297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"381.050663ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-02-25T19:25:18.236389Z","caller":"traceutil/trace.go:171","msg":"trace[1459476508] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:981; }","duration":"381.162275ms","start":"2026-02-25T19:25:17.855205Z","end":"2026-02-25T19:25:18.236367Z","steps":["trace[1459476508] 'agreement among raft nodes before linearized reading'  (duration: 380.851549ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:25:18.236444Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:25:17.855168Z","time spent":"381.266177ms","remote":"127.0.0.1:33500","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-02-25T19:25:18.236596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.596397ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T19:25:18.236627Z","caller":"traceutil/trace.go:171","msg":"trace[1240114274] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:981; }","duration":"224.626768ms","start":"2026-02-25T19:25:18.011991Z","end":"2026-02-25T19:25:18.236618Z","steps":["trace[1240114274] 'agreement among raft nodes before linearized reading'  (duration: 224.567716ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:25:18.23696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"381.054392ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"info","ts":"2026-02-25T19:25:18.237054Z","caller":"traceutil/trace.go:171","msg":"trace[959631027] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:981; }","duration":"381.753166ms","start":"2026-02-25T19:25:17.85528Z","end":"2026-02-25T19:25:18.237033Z","steps":["trace[959631027] 'agreement among raft nodes before linearized reading'  (duration: 380.771638ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:25:18.237508Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:25:17.855271Z","time spent":"382.221775ms","remote":"127.0.0.1:33500","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-02-25T19:25:32.450466Z","caller":"traceutil/trace.go:171","msg":"trace[441722329] transaction","detail":"{read_only:false; response_revision:1026; number_of_response:1; }","duration":"114.475685ms","start":"2026-02-25T19:25:32.335955Z","end":"2026-02-25T19:25:32.45043Z","steps":["trace[441722329] 'process raft request'  (duration: 67.112577ms)","trace[441722329] 'compare'  (duration: 47.127554ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T19:25:32.450889Z","caller":"traceutil/trace.go:171","msg":"trace[1350437647] transaction","detail":"{read_only:false; response_revision:1027; number_of_response:1; }","duration":"114.047539ms","start":"2026-02-25T19:25:32.336819Z","end":"2026-02-25T19:25:32.450867Z","steps":["trace[1350437647] 'process raft request'  (duration: 113.490389ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:25:33.045021Z","caller":"traceutil/trace.go:171","msg":"trace[872567369] linearizableReadLoop","detail":"{readStateIndex:1075; appliedIndex:1074; }","duration":"148.771258ms","start":"2026-02-25T19:25:32.896233Z","end":"2026-02-25T19:25:33.045004Z","steps":["trace[872567369] 'read index received'  (duration: 148.648826ms)","trace[872567369] 'applied index is now lower than readState.Index'  (duration: 121.922µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T19:25:33.045117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.87019ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:kube-dns\" ","response":"range_response_count:1 size:674"}
{"level":"info","ts":"2026-02-25T19:25:33.045134Z","caller":"traceutil/trace.go:171","msg":"trace[1600353479] range","detail":"{range_begin:/registry/clusterrolebindings/system:kube-dns; range_end:; response_count:1; response_revision:1028; }","duration":"148.915731ms","start":"2026-02-25T19:25:32.896213Z","end":"2026-02-25T19:25:33.045128Z","steps":["trace[1600353479] 'agreement among raft nodes before linearized reading'  (duration: 148.87014ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:25:33.045124Z","caller":"traceutil/trace.go:171","msg":"trace[307393086] transaction","detail":"{read_only:false; response_revision:1028; number_of_response:1; }","duration":"167.857706ms","start":"2026-02-25T19:25:32.87724Z","end":"2026-02-25T19:25:33.045098Z","steps":["trace[307393086] 'process raft request'  (duration: 167.685283ms)"],"step_count":1}