{"level":"warn","ts":"2026-02-12T02:08:24.594007Z","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-12T02:08:24.594252Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.141: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.141:2380","--initial-cluster=instance=https://199.204.45.141:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.141:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.141: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-12T02:08:24.59441Z","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-12T02:08:24.594479Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.141:2380"]}
{"level":"info","ts":"2026-02-12T02:08:24.594557Z","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-12T02:08:24.595294Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.141:2379"]}
{"level":"info","ts":"2026-02-12T02:08:24.595433Z","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":2,"max-cpu-available":2,"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.141:2380"],"listen-peer-urls":["https://199.204.45.141:2380"],"advertise-client-urls":["https://199.204.45.141:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.141:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.141: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-12T02:08:24.608255Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"12.553146ms"}
{"level":"info","ts":"2026-02-12T02:08:24.635468Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"9ef3b4f68930dc2","cluster-id":"b19a5957e6e65747"}
{"level":"info","ts":"2026-02-12T02:08:24.635537Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 switched to configuration voters=()"}
{"level":"info","ts":"2026-02-12T02:08:24.635556Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 became follower at term 0"}
{"level":"info","ts":"2026-02-12T02:08:24.635563Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 9ef3b4f68930dc2 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-02-12T02:08:24.635572Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 became follower at term 1"}
{"level":"info","ts":"2026-02-12T02:08:24.635599Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 switched to configuration voters=(715856078018121154)"}
{"level":"warn","ts":"2026-02-12T02:08:24.648035Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-02-12T02:08:24.655615Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-02-12T02:08:24.664564Z","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-12T02:08:24.670163Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"9ef3b4f68930dc2","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-02-12T02:08:24.671538Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"9ef3b4f68930dc2","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-02-12T02:08:24.671743Z","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-12T02:08:24.671782Z","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-12T02:08:24.67179Z","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-12T02:08:24.67207Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 switched to configuration voters=(715856078018121154)"}
{"level":"info","ts":"2026-02-12T02:08:24.672176Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"b19a5957e6e65747","local-member-id":"9ef3b4f68930dc2","added-peer-id":"9ef3b4f68930dc2","added-peer-peer-urls":["https://199.204.45.141:2380"]}
{"level":"info","ts":"2026-02-12T02:08:24.67884Z","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-12T02:08:24.679068Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.141:2380"}
{"level":"info","ts":"2026-02-12T02:08:24.67913Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.141:2380"}
{"level":"info","ts":"2026-02-12T02:08:24.683554Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"9ef3b4f68930dc2","initial-advertise-peer-urls":["https://199.204.45.141:2380"],"listen-peer-urls":["https://199.204.45.141:2380"],"advertise-client-urls":["https://199.204.45.141:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.141:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-02-12T02:08:24.683593Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-02-12T02:08:25.33622Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 is starting a new election at term 1"}
{"level":"info","ts":"2026-02-12T02:08:25.336263Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 became pre-candidate at term 1"}
{"level":"info","ts":"2026-02-12T02:08:25.336281Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 received MsgPreVoteResp from 9ef3b4f68930dc2 at term 1"}
{"level":"info","ts":"2026-02-12T02:08:25.336336Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 became candidate at term 2"}
{"level":"info","ts":"2026-02-12T02:08:25.336349Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 received MsgVoteResp from 9ef3b4f68930dc2 at term 2"}
{"level":"info","ts":"2026-02-12T02:08:25.336357Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 became leader at term 2"}
{"level":"info","ts":"2026-02-12T02:08:25.336405Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 9ef3b4f68930dc2 elected leader 9ef3b4f68930dc2 at term 2"}
{"level":"info","ts":"2026-02-12T02:08:25.35551Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"9ef3b4f68930dc2","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.141:2379]}","request-path":"/0/members/9ef3b4f68930dc2/attributes","cluster-id":"b19a5957e6e65747","publish-timeout":"7s"}
{"level":"info","ts":"2026-02-12T02:08:25.359594Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-02-12T02:08:25.359946Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-12T02:08:25.36007Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-02-12T02:08:25.37647Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-02-12T02:08:25.376486Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-02-12T02:08:25.377767Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-02-12T02:08:25.401676Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.141:2379"}
{"level":"info","ts":"2026-02-12T02:08:25.456299Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"b19a5957e6e65747","local-member-id":"9ef3b4f68930dc2","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-12T02:08:25.498453Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-12T02:08:25.516495Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-12T02:08:27.533865Z","caller":"traceutil/trace.go:171","msg":"trace[1060476640] transaction","detail":"{read_only:false; response_revision:2; number_of_response:1; }","duration":"488.655236ms","start":"2026-02-12T02:08:27.045172Z","end":"2026-02-12T02:08:27.533827Z","steps":["trace[1060476640] 'process raft request'  (duration: 488.037287ms)"],"step_count":1}
{"level":"info","ts":"2026-02-12T02:08:27.534552Z","caller":"traceutil/trace.go:171","msg":"trace[660244582] linearizableReadLoop","detail":"{readStateIndex:5; appliedIndex:4; }","duration":"487.972785ms","start":"2026-02-12T02:08:27.04555Z","end":"2026-02-12T02:08:27.533523Z","steps":["trace[660244582] 'read index received'  (duration: 487.624594ms)","trace[660244582] 'applied index is now lower than readState.Index'  (duration: 347.041µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-12T02:08:27.534745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"489.156412ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-02-12T02:08:27.535397Z","caller":"traceutil/trace.go:171","msg":"trace[772660551] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:2; }","duration":"490.052699ms","start":"2026-02-12T02:08:27.045336Z","end":"2026-02-12T02:08:27.535389Z","steps":["trace[772660551] 'agreement among raft nodes before linearized reading'  (duration: 489.277556ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:08:27.535445Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:08:27.045332Z","time spent":"490.105681ms","remote":"127.0.0.1:42942","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":0,"response size":27,"request content":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" "}
{"level":"warn","ts":"2026-02-12T02:08:27.536162Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:08:27.04516Z","time spent":"489.982857ms","remote":"127.0.0.1:43210","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":698,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/prioritylevelconfigurations/system\" mod_revision:0 > success:<request_put:<key:\"/registry/prioritylevelconfigurations/system\" value_size:646 >> failure:<>"}
{"level":"info","ts":"2026-02-12T02:08:27.734804Z","caller":"traceutil/trace.go:171","msg":"trace[1767206344] linearizableReadLoop","detail":"{readStateIndex:14; appliedIndex:5; }","duration":"199.426335ms","start":"2026-02-12T02:08:27.53536Z","end":"2026-02-12T02:08:27.734786Z","steps":["trace[1767206344] 'read index received'  (duration: 197.93139ms)","trace[1767206344] 'applied index is now lower than readState.Index'  (duration: 1.494255ms)"],"step_count":2}
{"level":"info","ts":"2026-02-12T02:08:27.735632Z","caller":"traceutil/trace.go:171","msg":"trace[468869372] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"686.892455ms","start":"2026-02-12T02:08:27.048597Z","end":"2026-02-12T02:08:27.735489Z","steps":["trace[468869372] 'process raft request'  (duration: 684.718779ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:08:27.737786Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:08:27.048586Z","time spent":"689.097122ms","remote":"127.0.0.1:42872","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":338,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/namespaces/kube-system\" mod_revision:0 > success:<request_put:<key:\"/registry/namespaces/kube-system\" value_size:298 >> failure:<>"}
{"level":"info","ts":"2026-02-12T02:08:27.735795Z","caller":"traceutil/trace.go:171","msg":"trace[311094287] transaction","detail":"{read_only:false; number_of_response:0; response_revision:3; }","duration":"687.096523ms","start":"2026-02-12T02:08:27.048681Z","end":"2026-02-12T02:08:27.735777Z","steps":["trace[311094287] 'process raft request'  (duration: 684.751481ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:08:27.739087Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:08:27.048676Z","time spent":"690.388423ms","remote":"127.0.0.1:42872","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":27,"request content":"compare:<target:MOD key:\"/registry/namespaces/kube-system\" mod_revision:0 > success:<request_put:<key:\"/registry/namespaces/kube-system\" value_size:298 >> failure:<>"}
{"level":"info","ts":"2026-02-12T02:08:27.736024Z","caller":"traceutil/trace.go:171","msg":"trace[356554570] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"683.881304ms","start":"2026-02-12T02:08:27.052008Z","end":"2026-02-12T02:08:27.73589Z","steps":["trace[356554570] 'process raft request'  (duration: 682.585574ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:08:27.739944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"691.393023ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:2859"}
{"level":"info","ts":"2026-02-12T02:08:27.740042Z","caller":"traceutil/trace.go:171","msg":"trace[1405297125] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:10; }","duration":"691.496537ms","start":"2026-02-12T02:08:27.048512Z","end":"2026-02-12T02:08:27.740008Z","steps":["trace[1405297125] 'agreement among raft nodes before linearized reading'  (duration: 686.484283ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:08:27.740093Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:08:27.048507Z","time spent":"691.574989ms","remote":"127.0.0.1:42936","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":2882,"request content":"key:\"/registry/minions/instance\" "}
{"level":"warn","ts":"2026-02-12T02:08:27.739992Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:08:27.052001Z","time spent":"687.967838ms","remote":"127.0.0.1:43304","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/apiregistration.k8s.io/apiservices/v1.\" mod_revision:0 > success:<request_put:<key:\"/registry/apiregistration.k8s.io/apiservices/v1.\" value_size:827 >> failure:<>"}
{"level":"info","ts":"2026-02-12T02:08:27.736229Z","caller":"traceutil/trace.go:171","msg":"trace[962354856] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"683.977696ms","start":"2026-02-12T02:08:27.052179Z","end":"2026-02-12T02:08:27.736157Z","steps":["trace[962354856] 'process raft request'  (duration: 682.48248ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:08:27.740762Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:08:27.052174Z","time spent":"688.565376ms","remote":"127.0.0.1:43304","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":920,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/apiregistration.k8s.io/apiservices/v1.apps\" mod_revision:0 > success:<request_put:<key:\"/registry/apiregistration.k8s.io/apiservices/v1.apps\" value_size:860 >> failure:<>"}
{"level":"info","ts":"2026-02-12T02:08:27.7364Z","caller":"traceutil/trace.go:171","msg":"trace[214254507] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"684.034838ms","start":"2026-02-12T02:08:27.052209Z","end":"2026-02-12T02:08:27.736244Z","steps":["trace[214254507] 'process raft request'  (duration: 682.47357ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:08:27.742404Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:08:27.052206Z","time spent":"690.160895ms","remote":"127.0.0.1:43304","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":971,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/apiregistration.k8s.io/apiservices/v1.authentication.k8s.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiregistration.k8s.io/apiservices/v1.authentication.k8s.io\" value_size:894 >> failure:<>"}
{"level":"info","ts":"2026-02-12T02:08:27.742545Z","caller":"traceutil/trace.go:171","msg":"trace[250948346] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"682.041597ms","start":"2026-02-12T02:08:27.060477Z","end":"2026-02-12T02:08:27.742519Z","steps":["trace[250948346] 'process raft request'  (duration: 674.262318ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:08:27.742652Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:08:27.060413Z","time spent":"682.179082ms","remote":"127.0.0.1:42936","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2847,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:0 > success:<request_put:<key:\"/registry/minions/instance\" value_size:2813 >> failure:<>"}
{"level":"info","ts":"2026-02-12T02:08:27.742991Z","caller":"traceutil/trace.go:171","msg":"trace[1939639733] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"673.851917ms","start":"2026-02-12T02:08:27.06913Z","end":"2026-02-12T02:08:27.742982Z","steps":["trace[1939639733] 'process raft request'  (duration: 665.628635ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:08:27.743047Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:08:27.069107Z","time spent":"673.915069ms","remote":"127.0.0.1:43026","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":849,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/certificatesigningrequests/csr-zk4l6\" mod_revision:0 > success:<request_put:<key:\"/registry/certificatesigningrequests/csr-zk4l6\" value_size:795 >> failure:<>"}
{"level":"info","ts":"2026-02-12T02:08:27.736523Z","caller":"traceutil/trace.go:171","msg":"trace[973399127] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"684.182532ms","start":"2026-02-12T02:08:27.052239Z","end":"2026-02-12T02:08:27.736422Z","steps":["trace[973399127] 'process raft request'  (duration: 682.464719ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:08:27.743673Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:08:27.052224Z","time spent":"691.432704ms","remote":"127.0.0.1:43304","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/apiregistration.k8s.io/apiservices/v1.admissionregistration.k8s.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiregistration.k8s.io/apiservices/v1.admissionregistration.k8s.io\" value_size:908 >> failure:<>"}
{"level":"warn","ts":"2026-02-12T02:08:27.744319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.184463ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-02-12T02:08:27.744392Z","caller":"traceutil/trace.go:171","msg":"trace[1638983535] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:0; response_revision:11; }","duration":"207.281116ms","start":"2026-02-12T02:08:27.537102Z","end":"2026-02-12T02:08:27.744383Z","steps":["trace[1638983535] 'agreement among raft nodes before linearized reading'  (duration: 206.886324ms)"],"step_count":1}
{"level":"info","ts":"2026-02-12T02:08:27.736758Z","caller":"traceutil/trace.go:171","msg":"trace[242872754] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"684.43852ms","start":"2026-02-12T02:08:27.052251Z","end":"2026-02-12T02:08:27.736689Z","steps":["trace[242872754] 'process raft request'  (duration: 682.46873ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:08:27.745543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"587.054603ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"}
{"level":"info","ts":"2026-02-12T02:08:27.745588Z","caller":"traceutil/trace.go:171","msg":"trace[962464796] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:11; }","duration":"587.124387ms","start":"2026-02-12T02:08:27.158446Z","end":"2026-02-12T02:08:27.745571Z","steps":["trace[962464796] 'agreement among raft nodes before linearized reading'  (duration: 584.714463ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:08:27.745625Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:08:27.158413Z","time spent":"587.196019ms","remote":"127.0.0.1:42872","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":373,"request content":"key:\"/registry/namespaces/kube-system\" "}
{"level":"warn","ts":"2026-02-12T02:08:27.745718Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:08:27.052246Z","time spent":"693.308261ms","remote":"127.0.0.1:43304","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/apiregistration.k8s.io/apiservices/v1.apiextensions.k8s.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiregistration.k8s.io/apiservices/v1.apiextensions.k8s.io\" value_size:892 >> failure:<>"}
{"level":"info","ts":"2026-02-12T02:08:27.747133Z","caller":"traceutil/trace.go:171","msg":"trace[732088978] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"208.099232ms","start":"2026-02-12T02:08:27.539024Z","end":"2026-02-12T02:08:27.747123Z","steps":["trace[732088978] 'process raft request'  (duration: 204.894333ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:08:27.748759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"642.164228ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.141\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-02-12T02:08:27.751464Z","caller":"traceutil/trace.go:171","msg":"trace[2111378541] range","detail":"{range_begin:/registry/masterleases/199.204.45.141; range_end:; response_count:0; response_revision:11; }","duration":"644.915402ms","start":"2026-02-12T02:08:27.106539Z","end":"2026-02-12T02:08:27.751454Z","steps":["trace[2111378541] 'agreement among raft nodes before linearized reading'  (duration: 642.195729ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:08:27.749128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"651.541545ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"}
{"level":"warn","ts":"2026-02-12T02:08:27.749153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"653.536616ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"}
{"level":"warn","ts":"2026-02-12T02:08:27.749175Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"654.208826ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"}
{"level":"warn","ts":"2026-02-12T02:08:27.749192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"700.46255ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/servicenodeports\" ","response":"range_response_count:0 size:4"}
{"level":"warn","ts":"2026-02-12T02:08:27.751692Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:08:27.106512Z","time spent":"645.17117ms","remote":"127.0.0.1:42800","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":0,"response size":27,"request content":"key:\"/registry/masterleases/199.204.45.141\" "}
{"level":"info","ts":"2026-02-12T02:08:27.751941Z","caller":"traceutil/trace.go:171","msg":"trace[2100973504] range","detail":"{range_begin:/registry/ranges/servicenodeports; range_end:; response_count:0; response_revision:11; }","duration":"703.215964ms","start":"2026-02-12T02:08:27.048719Z","end":"2026-02-12T02:08:27.751935Z","steps":["trace[2100973504] 'agreement among raft nodes before linearized reading'  (duration: 700.4629ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:08:27.751995Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:08:27.048716Z","time spent":"703.273236ms","remote":"127.0.0.1:42842","response type":"/etcdserverpb.KV/Range","request count":0,"request size":35,"response count":0,"response size":27,"request content":"key:\"/registry/ranges/servicenodeports\" "}
{"level":"info","ts":"2026-02-12T02:08:27.75171Z","caller":"traceutil/trace.go:171","msg":"trace[1203785777] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:11; }","duration":"654.148034ms","start":"2026-02-12T02:08:27.097556Z","end":"2026-02-12T02:08:27.751704Z","steps":["trace[1203785777] 'agreement among raft nodes before linearized reading'  (duration: 651.546324ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:08:27.75248Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:08:27.097546Z","time spent":"654.927148ms","remote":"127.0.0.1:42872","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":373,"request content":"key:\"/registry/namespaces/kube-system\" "}
{"level":"info","ts":"2026-02-12T02:08:27.75179Z","caller":"traceutil/trace.go:171","msg":"trace[28770109] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:11; }","duration":"656.192667ms","start":"2026-02-12T02:08:27.095591Z","end":"2026-02-12T02:08:27.751784Z","steps":["trace[28770109] 'agreement among raft nodes before linearized reading'  (duration: 653.548656ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:08:27.752652Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:08:27.095577Z","time spent":"657.069334ms","remote":"127.0.0.1:42872","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":373,"request content":"key:\"/registry/namespaces/kube-system\" "}
{"level":"info","ts":"2026-02-12T02:08:27.751864Z","caller":"traceutil/trace.go:171","msg":"trace[165793238] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:11; }","duration":"656.940469ms","start":"2026-02-12T02:08:27.094918Z","end":"2026-02-12T02:08:27.751858Z","steps":["trace[165793238] 'agreement among raft nodes before linearized reading'  (duration: 654.241827ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:08:27.75283Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:08:27.094904Z","time spent":"657.91963ms","remote":"127.0.0.1:42872","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":373,"request content":"key:\"/registry/namespaces/kube-system\" "}
{"level":"warn","ts":"2026-02-12T02:08:33.709816Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"780.263045ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-02-12T02:08:33.709903Z","caller":"traceutil/trace.go:171","msg":"trace[1198197415] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:287; }","duration":"780.41063ms","start":"2026-02-12T02:08:32.929472Z","end":"2026-02-12T02:08:33.709882Z","steps":["trace[1198197415] 'range keys from in-memory index tree'  (duration: 780.165752ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:08:33.709947Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:08:32.929454Z","time spent":"780.484071ms","remote":"127.0.0.1:43028","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-02-12T02:08:33.709845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"872.300665ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"}
{"level":"info","ts":"2026-02-12T02:08:33.710354Z","caller":"traceutil/trace.go:171","msg":"trace[1225506422] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:287; }","duration":"872.829269ms","start":"2026-02-12T02:08:32.837483Z","end":"2026-02-12T02:08:33.710312Z","steps":["trace[1225506422] 'range keys from in-memory index tree'  (duration: 872.232212ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:08:33.710499Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:08:32.837469Z","time spent":"872.997504ms","remote":"127.0.0.1:42872","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":374,"request content":"key:\"/registry/namespaces/kube-system\" "}
{"level":"warn","ts":"2026-02-12T02:08:38.020618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.295766ms","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-12T02:08:38.020852Z","caller":"traceutil/trace.go:171","msg":"trace[29458355] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:356; }","duration":"183.566483ms","start":"2026-02-12T02:08:37.837262Z","end":"2026-02-12T02:08:38.020828Z","steps":["trace[29458355] 'range keys from in-memory index tree'  (duration: 183.189492ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:08:38.020745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.570135ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-02-12T02:08:38.021156Z","caller":"traceutil/trace.go:171","msg":"trace[1824851954] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:356; }","duration":"182.901893ms","start":"2026-02-12T02:08:37.838128Z","end":"2026-02-12T02:08:38.021029Z","steps":["trace[1824851954] 'range keys from in-memory index tree'  (duration: 182.503683ms)"],"step_count":1}
{"level":"info","ts":"2026-02-12T02:08:38.052941Z","caller":"traceutil/trace.go:171","msg":"trace[1687176216] transaction","detail":"{read_only:false; response_revision:357; number_of_response:1; }","duration":"189.170687ms","start":"2026-02-12T02:08:37.863748Z","end":"2026-02-12T02:08:38.052919Z","steps":["trace[1687176216] 'process raft request'  (duration: 189.022023ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:08:39.09702Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":991526733697007161,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-02-12T02:08:39.25422Z","caller":"traceutil/trace.go:171","msg":"trace[655256398] linearizableReadLoop","detail":"{readStateIndex:374; appliedIndex:373; }","duration":"657.463124ms","start":"2026-02-12T02:08:38.596735Z","end":"2026-02-12T02:08:39.254198Z","steps":["trace[655256398] 'read index received'  (duration: 657.298749ms)","trace[655256398] 'applied index is now lower than readState.Index'  (duration: 163.845µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-12T02:08:39.25444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"657.691099ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.141\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-02-12T02:08:39.254481Z","caller":"traceutil/trace.go:171","msg":"trace[1398063819] range","detail":"{range_begin:/registry/masterleases/199.204.45.141; range_end:; response_count:1; response_revision:361; }","duration":"657.772342ms","start":"2026-02-12T02:08:38.596701Z","end":"2026-02-12T02:08:39.254474Z","steps":["trace[1398063819] 'agreement among raft nodes before linearized reading'  (duration: 657.666699ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:08:39.25452Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:08:38.596689Z","time spent":"657.823933ms","remote":"127.0.0.1:42800","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.141\" "}
{"level":"info","ts":"2026-02-12T02:08:39.254844Z","caller":"traceutil/trace.go:171","msg":"trace[556062744] transaction","detail":"{read_only:false; response_revision:361; number_of_response:1; }","duration":"706.78718ms","start":"2026-02-12T02:08:38.548049Z","end":"2026-02-12T02:08:39.254836Z","steps":["trace[556062744] 'process raft request'  (duration: 706.032379ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:08:39.255045Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:08:38.548031Z","time spent":"706.855832ms","remote":"127.0.0.1:42938","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4053,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/kube-scheduler-instance\" mod_revision:355 > success:<request_put:<key:\"/registry/pods/kube-system/kube-scheduler-instance\" value_size:3995 >> failure:<request_range:<key:\"/registry/pods/kube-system/kube-scheduler-instance\" > >"}
{"level":"warn","ts":"2026-02-12T02:08:40.245993Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"911.497549ms","expected-duration":"100ms","prefix":"","request":"header:<ID:991526733697007165 username:\"kube-apiserver-etcd-client\" auth_revision:1 > lease_grant:<ttl:15-second id:0dc29c4f9b503e3c>","response":"size:40"}
{"level":"info","ts":"2026-02-12T02:08:40.246217Z","caller":"traceutil/trace.go:171","msg":"trace[798103095] linearizableReadLoop","detail":"{readStateIndex:375; appliedIndex:374; }","duration":"491.680733ms","start":"2026-02-12T02:08:39.754523Z","end":"2026-02-12T02:08:40.246204Z","steps":["trace[798103095] 'read index received'  (duration: 34.671µs)","trace[798103095] 'applied index is now lower than readState.Index'  (duration: 491.644862ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-12T02:08:40.246362Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:08:39.259559Z","time spent":"986.799902ms","remote":"127.0.0.1:42800","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"warn","ts":"2026-02-12T02:08:40.246828Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"492.27385ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-02-12T02:08:40.246912Z","caller":"traceutil/trace.go:171","msg":"trace[1842902555] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:361; }","duration":"492.404223ms","start":"2026-02-12T02:08:39.754482Z","end":"2026-02-12T02:08:40.246886Z","steps":["trace[1842902555] 'agreement among raft nodes before linearized reading'  (duration: 492.223638ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:08:40.246978Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:08:39.754464Z","time spent":"492.504465ms","remote":"127.0.0.1:43028","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-02-12T02:08:40.247052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.1366ms","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-12T02:08:40.247131Z","caller":"traceutil/trace.go:171","msg":"trace[333422508] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:361; }","duration":"182.412977ms","start":"2026-02-12T02:08:40.064706Z","end":"2026-02-12T02:08:40.247119Z","steps":["trace[333422508] 'agreement among raft nodes before linearized reading'  (duration: 182.1281ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:08:40.247526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.720827ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-02-12T02:08:40.247582Z","caller":"traceutil/trace.go:171","msg":"trace[944169704] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:361; }","duration":"148.790798ms","start":"2026-02-12T02:08:40.098778Z","end":"2026-02-12T02:08:40.247569Z","steps":["trace[944169704] 'agreement among raft nodes before linearized reading'  (duration: 148.709926ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:08:40.247838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.068914ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-02-12T02:08:40.247869Z","caller":"traceutil/trace.go:171","msg":"trace[1425426088] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:361; }","duration":"183.110225ms","start":"2026-02-12T02:08:40.06475Z","end":"2026-02-12T02:08:40.247861Z","steps":["trace[1425426088] 'agreement among raft nodes before linearized reading'  (duration: 183.056824ms)"],"step_count":1}
{"level":"info","ts":"2026-02-12T02:08:40.473034Z","caller":"traceutil/trace.go:171","msg":"trace[2054233950] transaction","detail":"{read_only:false; response_revision:367; number_of_response:1; }","duration":"173.384727ms","start":"2026-02-12T02:08:40.299633Z","end":"2026-02-12T02:08:40.473018Z","steps":["trace[2054233950] 'process raft request'  (duration: 173.348336ms)"],"step_count":1}
{"level":"info","ts":"2026-02-12T02:08:40.473589Z","caller":"traceutil/trace.go:171","msg":"trace[1003888787] transaction","detail":"{read_only:false; response_revision:365; number_of_response:1; }","duration":"202.742603ms","start":"2026-02-12T02:08:40.270837Z","end":"2026-02-12T02:08:40.473579Z","steps":["trace[1003888787] 'process raft request'  (duration: 173.058209ms)","trace[1003888787] 'compare'  (duration: 28.980024ms)"],"step_count":2}
{"level":"info","ts":"2026-02-12T02:08:40.473684Z","caller":"traceutil/trace.go:171","msg":"trace[1325408021] transaction","detail":"{read_only:false; response_revision:366; number_of_response:1; }","duration":"202.817735ms","start":"2026-02-12T02:08:40.27086Z","end":"2026-02-12T02:08:40.473678Z","steps":["trace[1325408021] 'process raft request'  (duration: 202.092384ms)"],"step_count":1}
{"level":"info","ts":"2026-02-12T02:08:40.473758Z","caller":"traceutil/trace.go:171","msg":"trace[696411259] linearizableReadLoop","detail":"{readStateIndex:380; appliedIndex:378; }","duration":"179.070779ms","start":"2026-02-12T02:08:40.294679Z","end":"2026-02-12T02:08:40.473749Z","steps":["trace[696411259] 'read index received'  (duration: 149.226701ms)","trace[696411259] 'applied index is now lower than readState.Index'  (duration: 29.843488ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-12T02:08:40.473828Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.141981ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:422"}
{"level":"info","ts":"2026-02-12T02:08:40.473858Z","caller":"traceutil/trace.go:171","msg":"trace[1847119474] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:367; }","duration":"179.211383ms","start":"2026-02-12T02:08:40.294638Z","end":"2026-02-12T02:08:40.47385Z","steps":["trace[1847119474] 'agreement among raft nodes before linearized reading'  (duration: 179.143961ms)"],"step_count":1}
{"level":"info","ts":"2026-02-12T02:08:42.389705Z","caller":"traceutil/trace.go:171","msg":"trace[64638493] transaction","detail":"{read_only:false; response_revision:373; number_of_response:1; }","duration":"113.846315ms","start":"2026-02-12T02:08:42.275836Z","end":"2026-02-12T02:08:42.389682Z","steps":["trace[64638493] 'process raft request'  (duration: 113.505205ms)"],"step_count":1}
{"level":"info","ts":"2026-02-12T02:08:43.576225Z","caller":"traceutil/trace.go:171","msg":"trace[657077907] transaction","detail":"{read_only:false; response_revision:379; number_of_response:1; }","duration":"100.441037ms","start":"2026-02-12T02:08:43.475761Z","end":"2026-02-12T02:08:43.576202Z","steps":["trace[657077907] 'process raft request'  (duration: 100.287563ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:08:50.954433Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":991526733697007287,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-12T02:08:51.454945Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":991526733697007287,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-12T02:08:51.9555Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":991526733697007287,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-12T02:08:52.446609Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.999792784s","expected-duration":"1s"}
{"level":"info","ts":"2026-02-12T02:08:52.446978Z","caller":"traceutil/trace.go:171","msg":"trace[1271628402] transaction","detail":"{read_only:false; response_revision:423; number_of_response:1; }","duration":"2.000242194s","start":"2026-02-12T02:08:50.44672Z","end":"2026-02-12T02:08:52.446962Z","steps":["trace[1271628402] 'process raft request'  (duration: 2.000151862s)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:08:52.44706Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:08:50.446696Z","time spent":"2.000307795s","remote":"127.0.0.1:43028","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:418 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-02-12T02:08:52.755153Z","caller":"traceutil/trace.go:171","msg":"trace[1440942954] linearizableReadLoop","detail":"{readStateIndex:440; appliedIndex:439; }","duration":"2.300916609s","start":"2026-02-12T02:08:50.454218Z","end":"2026-02-12T02:08:52.755134Z","steps":["trace[1440942954] 'read index received'  (duration: 1.993132122s)","trace[1440942954] 'applied index is now lower than readState.Index'  (duration: 307.783797ms)"],"step_count":2}
{"level":"info","ts":"2026-02-12T02:08:52.755246Z","caller":"traceutil/trace.go:171","msg":"trace[40887814] transaction","detail":"{read_only:false; response_revision:424; number_of_response:1; }","duration":"1.831942642s","start":"2026-02-12T02:08:50.923293Z","end":"2026-02-12T02:08:52.755236Z","steps":["trace[40887814] 'process raft request'  (duration: 1.793899015s)","trace[40887814] 'compare'  (duration: 37.876333ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-12T02:08:52.755315Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:08:50.923271Z","time spent":"1.831992543s","remote":"127.0.0.1:43028","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:370 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"warn","ts":"2026-02-12T02:08:52.755403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.237928099s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-02-12T02:08:52.755457Z","caller":"traceutil/trace.go:171","msg":"trace[2020678737] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:424; }","duration":"2.238019201s","start":"2026-02-12T02:08:50.517424Z","end":"2026-02-12T02:08:52.755443Z","steps":["trace[2020678737] 'agreement among raft nodes before linearized reading'  (duration: 2.237924809s)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:08:52.755486Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:08:50.517407Z","time spent":"2.238071483s","remote":"127.0.0.1:43028","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-02-12T02:08:52.755555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.255462ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-12T02:08:52.75558Z","caller":"traceutil/trace.go:171","msg":"trace[1018322651] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:424; }","duration":"205.305073ms","start":"2026-02-12T02:08:52.550267Z","end":"2026-02-12T02:08:52.755572Z","steps":["trace[1018322651] 'agreement among raft nodes before linearized reading'  (duration: 205.266492ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:08:52.755612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.439708189s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-12T02:08:52.755633Z","caller":"traceutil/trace.go:171","msg":"trace[1352056477] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:424; }","duration":"1.439764529s","start":"2026-02-12T02:08:51.315862Z","end":"2026-02-12T02:08:52.755627Z","steps":["trace[1352056477] 'agreement among raft nodes before linearized reading'  (duration: 1.439735439s)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:08:52.755652Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:08:51.315845Z","time spent":"1.439803311s","remote":"127.0.0.1:42760","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-12T02:08:52.755698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.301478412s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-02-12T02:08:52.755718Z","caller":"traceutil/trace.go:171","msg":"trace[1224446390] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:424; }","duration":"2.301512552s","start":"2026-02-12T02:08:50.4542Z","end":"2026-02-12T02:08:52.755713Z","steps":["trace[1224446390] 'agreement among raft nodes before linearized reading'  (duration: 2.301475961s)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:08:52.755735Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:08:50.454191Z","time spent":"2.301540423s","remote":"127.0.0.1:43028","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-02-12T02:08:52.755747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.232263681s","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-12T02:08:52.755768Z","caller":"traceutil/trace.go:171","msg":"trace[751179789] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:424; }","duration":"2.232319072s","start":"2026-02-12T02:08:50.523441Z","end":"2026-02-12T02:08:52.755761Z","steps":["trace[751179789] 'agreement among raft nodes before linearized reading'  (duration: 2.232284302s)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:08:52.755785Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:08:50.523422Z","time spent":"2.232358924s","remote":"127.0.0.1:43028","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-12T02:08:52.954842Z","caller":"traceutil/trace.go:171","msg":"trace[132436982] transaction","detail":"{read_only:false; response_revision:427; number_of_response:1; }","duration":"185.134593ms","start":"2026-02-12T02:08:52.769681Z","end":"2026-02-12T02:08:52.954816Z","steps":["trace[132436982] 'process raft request'  (duration: 185.069432ms)"],"step_count":1}
{"level":"info","ts":"2026-02-12T02:08:52.956025Z","caller":"traceutil/trace.go:171","msg":"trace[744092008] transaction","detail":"{read_only:false; response_revision:426; number_of_response:1; }","duration":"188.773369ms","start":"2026-02-12T02:08:52.767231Z","end":"2026-02-12T02:08:52.956005Z","steps":["trace[744092008] 'process raft request'  (duration: 129.210799ms)","trace[744092008] 'compare'  (duration: 57.908281ms)"],"step_count":2}
{"level":"info","ts":"2026-02-12T02:08:57.231365Z","caller":"traceutil/trace.go:171","msg":"trace[742644347] linearizableReadLoop","detail":"{readStateIndex:449; appliedIndex:448; }","duration":"344.859561ms","start":"2026-02-12T02:08:56.886487Z","end":"2026-02-12T02:08:57.231347Z","steps":["trace[742644347] 'read index received'  (duration: 344.555604ms)","trace[742644347] 'applied index is now lower than readState.Index'  (duration: 303.517µs)"],"step_count":2}
{"level":"info","ts":"2026-02-12T02:08:57.231516Z","caller":"traceutil/trace.go:171","msg":"trace[576122955] transaction","detail":"{read_only:false; response_revision:432; number_of_response:1; }","duration":"718.219093ms","start":"2026-02-12T02:08:56.513285Z","end":"2026-02-12T02:08:57.231504Z","steps":["trace[576122955] 'process raft request'  (duration: 717.976697ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:08:57.231597Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:08:56.513276Z","time spent":"718.265834ms","remote":"127.0.0.1:43028","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:428 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-02-12T02:08:57.23171Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.222849ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" ","response":"range_response_count:3 size:12669"}
{"level":"info","ts":"2026-02-12T02:08:57.231731Z","caller":"traceutil/trace.go:171","msg":"trace[1237358023] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:3; response_revision:432; }","duration":"345.274921ms","start":"2026-02-12T02:08:56.886449Z","end":"2026-02-12T02:08:57.231724Z","steps":["trace[1237358023] 'agreement among raft nodes before linearized reading'  (duration: 345.22546ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:08:57.231753Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:08:56.886433Z","time spent":"345.309981ms","remote":"127.0.0.1:42864","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":3,"response size":12692,"request content":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" "}
{"level":"warn","ts":"2026-02-12T02:08:57.232628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.440916ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-02-12T02:08:57.233178Z","caller":"traceutil/trace.go:171","msg":"trace[1477921893] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:432; }","duration":"340.006829ms","start":"2026-02-12T02:08:56.893147Z","end":"2026-02-12T02:08:57.233153Z","steps":["trace[1477921893] 'agreement among raft nodes before linearized reading'  (duration: 339.422176ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:08:57.234033Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:08:56.89314Z","time spent":"340.883398ms","remote":"127.0.0.1:43028","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-02-12T02:08:57.233242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.526401ms","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-12T02:08:57.234141Z","caller":"traceutil/trace.go:171","msg":"trace[904316839] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:432; }","duration":"244.450903ms","start":"2026-02-12T02:08:56.989682Z","end":"2026-02-12T02:08:57.234133Z","steps":["trace[904316839] 'agreement among raft nodes before linearized reading'  (duration: 243.531951ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:08:57.233272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.92608ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-02-12T02:08:57.234213Z","caller":"traceutil/trace.go:171","msg":"trace[829940885] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:432; }","duration":"254.904153ms","start":"2026-02-12T02:08:56.979304Z","end":"2026-02-12T02:08:57.234208Z","steps":["trace[829940885] 'agreement among raft nodes before linearized reading'  (duration: 253.95685ms)"],"step_count":1}
{"level":"info","ts":"2026-02-12T02:08:58.694551Z","caller":"traceutil/trace.go:171","msg":"trace[2056674104] linearizableReadLoop","detail":"{readStateIndex:453; appliedIndex:452; }","duration":"380.654735ms","start":"2026-02-12T02:08:58.313878Z","end":"2026-02-12T02:08:58.694532Z","steps":["trace[2056674104] 'read index received'  (duration: 380.325178ms)","trace[2056674104] 'applied index is now lower than readState.Index'  (duration: 328.987µs)"],"step_count":2}
{"level":"info","ts":"2026-02-12T02:08:58.694773Z","caller":"traceutil/trace.go:171","msg":"trace[812514737] transaction","detail":"{read_only:false; response_revision:436; number_of_response:1; }","duration":"556.378783ms","start":"2026-02-12T02:08:58.138387Z","end":"2026-02-12T02:08:58.694766Z","steps":["trace[812514737] 'process raft request'  (duration: 555.915762ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:08:58.694923Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:08:58.138365Z","time spent":"556.483516ms","remote":"127.0.0.1:42864","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":317280,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/secrets/kube-system/sh.helm.release.v1.cilium.v1\" mod_revision:0 > success:<request_put:<key:\"/registry/secrets/kube-system/sh.helm.release.v1.cilium.v1\" value_size:317212 >> failure:<>"}
{"level":"warn","ts":"2026-02-12T02:08:58.695148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"381.265409ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-12T02:08:58.695237Z","caller":"traceutil/trace.go:171","msg":"trace[1986784682] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:436; }","duration":"381.388331ms","start":"2026-02-12T02:08:58.313841Z","end":"2026-02-12T02:08:58.695229Z","steps":["trace[1986784682] 'agreement among raft nodes before linearized reading'  (duration: 381.266908ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:08:58.695338Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:08:58.313823Z","time spent":"381.508554ms","remote":"127.0.0.1:42750","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-12T02:08:58.698413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.09794ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.141\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-02-12T02:08:58.698525Z","caller":"traceutil/trace.go:171","msg":"trace[1595628692] range","detail":"{range_begin:/registry/masterleases/199.204.45.141; range_end:; response_count:1; response_revision:437; }","duration":"100.236304ms","start":"2026-02-12T02:08:58.59828Z","end":"2026-02-12T02:08:58.698517Z","steps":["trace[1595628692] 'agreement among raft nodes before linearized reading'  (duration: 100.097401ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:09:05.50378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.37956ms","expected-duration":"100ms","prefix":"","request":"header:<ID:991526733697007467 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:484 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-12T02:09:05.504135Z","caller":"traceutil/trace.go:171","msg":"trace[482184663] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"138.822281ms","start":"2026-02-12T02:09:05.365298Z","end":"2026-02-12T02:09:05.50412Z","steps":["trace[482184663] 'process raft request'  (duration: 32.041371ms)","trace[482184663] 'compare'  (duration: 106.299909ms)"],"step_count":2}
{"level":"info","ts":"2026-02-12T02:09:05.699261Z","caller":"traceutil/trace.go:171","msg":"trace[2060125636] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"191.477829ms","start":"2026-02-12T02:09:05.507768Z","end":"2026-02-12T02:09:05.699246Z","steps":["trace[2060125636] 'process raft request'  (duration: 190.970569ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:09:12.227108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"764.544559ms","expected-duration":"100ms","prefix":"","request":"header:<ID:991526733697007504 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:519 > 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-12T02:09:12.227175Z","caller":"traceutil/trace.go:171","msg":"trace[601228027] linearizableReadLoop","detail":"{readStateIndex:543; appliedIndex:542; }","duration":"702.763542ms","start":"2026-02-12T02:09:11.5244Z","end":"2026-02-12T02:09:12.227164Z","steps":["trace[601228027] 'read index received'  (duration: 24.471µs)","trace[601228027] 'applied index is now lower than readState.Index'  (duration: 702.738331ms)"],"step_count":2}
{"level":"info","ts":"2026-02-12T02:09:12.227297Z","caller":"traceutil/trace.go:171","msg":"trace[269246582] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"841.284993ms","start":"2026-02-12T02:09:11.386004Z","end":"2026-02-12T02:09:12.227289Z","steps":["trace[269246582] 'process raft request'  (duration: 76.506108ms)","trace[269246582] 'compare'  (duration: 764.004729ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-12T02:09:12.227333Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:09:11.385979Z","time spent":"841.334595ms","remote":"127.0.0.1:43028","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:519 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-02-12T02:09:12.227485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"703.088608ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-02-12T02:09:12.227504Z","caller":"traceutil/trace.go:171","msg":"trace[701741591] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:523; }","duration":"703.106428ms","start":"2026-02-12T02:09:11.524391Z","end":"2026-02-12T02:09:12.227497Z","steps":["trace[701741591] 'agreement among raft nodes before linearized reading'  (duration: 703.033017ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:09:12.227521Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:09:11.524339Z","time spent":"703.17858ms","remote":"127.0.0.1:43028","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-02-12T02:09:12.227618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"460.569764ms","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-12T02:09:12.227633Z","caller":"traceutil/trace.go:171","msg":"trace[1342243014] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:523; }","duration":"460.608186ms","start":"2026-02-12T02:09:11.76702Z","end":"2026-02-12T02:09:12.227628Z","steps":["trace[1342243014] 'agreement among raft nodes before linearized reading'  (duration: 460.563835ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:09:12.227649Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:09:11.767007Z","time spent":"460.638276ms","remote":"127.0.0.1:43028","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-12T02:09:12.386727Z","caller":"traceutil/trace.go:171","msg":"trace[426626611] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"154.03392ms","start":"2026-02-12T02:09:12.232677Z","end":"2026-02-12T02:09:12.38671Z","steps":["trace[426626611] 'process raft request'  (duration: 153.51273ms)"],"step_count":1}
{"level":"info","ts":"2026-02-12T02:09:12.387788Z","caller":"traceutil/trace.go:171","msg":"trace[1247419878] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"152.94665ms","start":"2026-02-12T02:09:12.234824Z","end":"2026-02-12T02:09:12.387771Z","steps":["trace[1247419878] 'process raft request'  (duration: 152.869529ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:09:13.812657Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":991526733697007509,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-12T02:09:14.28789Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.048279624s","expected-duration":"1s"}
{"level":"info","ts":"2026-02-12T02:09:14.288277Z","caller":"traceutil/trace.go:171","msg":"trace[1429614087] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"1.048719662s","start":"2026-02-12T02:09:13.239539Z","end":"2026-02-12T02:09:14.288259Z","steps":["trace[1429614087] 'process raft request'  (duration: 1.048585609s)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:09:14.288362Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:09:13.239523Z","time spent":"1.048786064s","remote":"127.0.0.1:43028","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:481 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:471 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"warn","ts":"2026-02-12T02:09:15.312571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000757888s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-02-12T02:09:15.312656Z","caller":"traceutil/trace.go:171","msg":"trace[675132654] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.00088473s","start":"2026-02-12T02:09:13.311751Z","end":"2026-02-12T02:09:15.312636Z","steps":["trace[675132654] 'agreement among raft nodes before linearized reading'  (duration: 2.000786719s)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:09:15.312694Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:09:13.311734Z","time spent":"2.000953871s","remote":"127.0.0.1:42750","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-12T02:09:15.430729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.388872ms","expected-duration":"100ms","prefix":"","request":"header:<ID:991526733697007511 > lease_revoke:<id:0dc29c4f9b503ee7>","response":"size:28"}
{"level":"info","ts":"2026-02-12T02:09:15.430793Z","caller":"traceutil/trace.go:171","msg":"trace[998825731] linearizableReadLoop","detail":"{readStateIndex:547; appliedIndex:546; }","duration":"2.118991685s","start":"2026-02-12T02:09:13.31179Z","end":"2026-02-12T02:09:15.430782Z","steps":["trace[998825731] 'read index received'  (duration: 976.899022ms)","trace[998825731] 'applied index is now lower than readState.Index'  (duration: 1.142091533s)"],"step_count":2}
{"level":"warn","ts":"2026-02-12T02:09:15.458472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.08046923s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-02-12T02:09:15.458518Z","caller":"traceutil/trace.go:171","msg":"trace[2071680988] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:527; }","duration":"2.080545831s","start":"2026-02-12T02:09:13.37796Z","end":"2026-02-12T02:09:15.458506Z","steps":["trace[2071680988] 'agreement among raft nodes before linearized reading'  (duration: 2.080411238s)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:09:15.458559Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:09:13.377946Z","time spent":"2.080606853s","remote":"127.0.0.1:43028","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-02-12T02:09:15.458757Z","caller":"traceutil/trace.go:171","msg":"trace[1493841721] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"141.053844ms","start":"2026-02-12T02:09:15.317651Z","end":"2026-02-12T02:09:15.458704Z","steps":["trace[1493841721] 'process raft request'  (duration: 140.629896ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:09:15.458864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.907241ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-12T02:09:15.458888Z","caller":"traceutil/trace.go:171","msg":"trace[63473080] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:527; }","duration":"140.967262ms","start":"2026-02-12T02:09:15.317915Z","end":"2026-02-12T02:09:15.458882Z","steps":["trace[63473080] 'agreement among raft nodes before linearized reading'  (duration: 140.931041ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:09:15.459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.067580816s","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-12T02:09:15.459022Z","caller":"traceutil/trace.go:171","msg":"trace[700417272] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:527; }","duration":"1.067616137s","start":"2026-02-12T02:09:14.391401Z","end":"2026-02-12T02:09:15.459017Z","steps":["trace[700417272] 'agreement among raft nodes before linearized reading'  (duration: 1.067559356s)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:09:15.459043Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:09:14.391393Z","time spent":"1.067646087s","remote":"127.0.0.1:43028","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-12T02:09:15.459144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.068290149s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-02-12T02:09:15.459167Z","caller":"traceutil/trace.go:171","msg":"trace[682939256] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:527; }","duration":"1.068340061s","start":"2026-02-12T02:09:14.390822Z","end":"2026-02-12T02:09:15.459162Z","steps":["trace[682939256] 'agreement among raft nodes before linearized reading'  (duration: 1.06828504s)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:09:15.459203Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:09:14.390806Z","time spent":"1.068391091s","remote":"127.0.0.1:43028","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-02-12T02:09:15.459304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.22677819s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-02-12T02:09:15.459326Z","caller":"traceutil/trace.go:171","msg":"trace[358227815] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:527; }","duration":"1.226821812s","start":"2026-02-12T02:09:14.232499Z","end":"2026-02-12T02:09:15.459321Z","steps":["trace[358227815] 'agreement among raft nodes before linearized reading'  (duration: 1.226772491s)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:09:15.459348Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:09:14.232484Z","time spent":"1.226860772s","remote":"127.0.0.1:43028","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-02-12T02:09:15.774528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.712576ms","expected-duration":"100ms","prefix":"","request":"header:<ID:991526733697007516 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:522 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-12T02:09:15.77459Z","caller":"traceutil/trace.go:171","msg":"trace[1131520294] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"307.551957ms","start":"2026-02-12T02:09:15.467027Z","end":"2026-02-12T02:09:15.774579Z","steps":["trace[1131520294] 'process raft request'  (duration: 88.743529ms)","trace[1131520294] 'compare'  (duration: 218.634945ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-12T02:09:15.774625Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:09:15.467018Z","time spent":"307.594288ms","remote":"127.0.0.1:43028","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:522 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-02-12T02:09:15.787559Z","caller":"traceutil/trace.go:171","msg":"trace[151176432] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"320.157934ms","start":"2026-02-12T02:09:15.467388Z","end":"2026-02-12T02:09:15.787546Z","steps":["trace[151176432] 'process raft request'  (duration: 320.128493ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:09:15.787648Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:09:15.467384Z","time spent":"320.217506ms","remote":"127.0.0.1:43028","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:523 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-02-12T02:09:15.787869Z","caller":"traceutil/trace.go:171","msg":"trace[1177984282] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"320.554313ms","start":"2026-02-12T02:09:15.467308Z","end":"2026-02-12T02:09:15.787862Z","steps":["trace[1177984282] 'process raft request'  (duration: 320.127214ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:09:15.78798Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:09:15.4673Z","time spent":"320.589043ms","remote":"127.0.0.1:43028","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:525 > 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-12T02:09:15.788188Z","caller":"traceutil/trace.go:171","msg":"trace[1569182968] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"320.820008ms","start":"2026-02-12T02:09:15.467358Z","end":"2026-02-12T02:09:15.788178Z","steps":["trace[1569182968] 'process raft request'  (duration: 320.135184ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:09:15.788264Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:09:15.467354Z","time spent":"320.889059ms","remote":"127.0.0.1:43028","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:524 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-02-12T02:09:21.920911Z","caller":"traceutil/trace.go:171","msg":"trace[991733746] linearizableReadLoop","detail":"{readStateIndex:567; appliedIndex:566; }","duration":"124.082493ms","start":"2026-02-12T02:09:21.796809Z","end":"2026-02-12T02:09:21.920892Z","steps":["trace[991733746] 'read index received'  (duration: 123.93009ms)","trace[991733746] 'applied index is now lower than readState.Index'  (duration: 151.602µs)"],"step_count":2}
{"level":"info","ts":"2026-02-12T02:09:21.921119Z","caller":"traceutil/trace.go:171","msg":"trace[710392342] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"129.128328ms","start":"2026-02-12T02:09:21.791981Z","end":"2026-02-12T02:09:21.92111Z","steps":["trace[710392342] 'process raft request'  (duration: 128.805972ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:09:21.921359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.534271ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-zkgf8\" ","response":"range_response_count:1 size:16656"}
{"level":"info","ts":"2026-02-12T02:09:21.921392Z","caller":"traceutil/trace.go:171","msg":"trace[459825270] range","detail":"{range_begin:/registry/pods/kube-system/cilium-zkgf8; range_end:; response_count:1; response_revision:545; }","duration":"124.587232ms","start":"2026-02-12T02:09:21.796793Z","end":"2026-02-12T02:09:21.921381Z","steps":["trace[459825270] 'agreement among raft nodes before linearized reading'  (duration: 124.45924ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:09:21.921903Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.909257ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-02-12T02:09:21.921938Z","caller":"traceutil/trace.go:171","msg":"trace[735040445] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:545; }","duration":"101.985969ms","start":"2026-02-12T02:09:21.819942Z","end":"2026-02-12T02:09:21.921928Z","steps":["trace[735040445] 'agreement among raft nodes before linearized reading'  (duration: 101.870646ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:09:21.922296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.925322ms","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-12T02:09:21.922325Z","caller":"traceutil/trace.go:171","msg":"trace[1057962511] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:545; }","duration":"114.967413ms","start":"2026-02-12T02:09:21.807349Z","end":"2026-02-12T02:09:21.922316Z","steps":["trace[1057962511] 'agreement among raft nodes before linearized reading'  (duration: 114.886411ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:09:21.921572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.825068ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-02-12T02:09:21.922522Z","caller":"traceutil/trace.go:171","msg":"trace[903444364] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:545; }","duration":"116.788226ms","start":"2026-02-12T02:09:21.805726Z","end":"2026-02-12T02:09:21.922514Z","steps":["trace[903444364] 'agreement among raft nodes before linearized reading'  (duration: 115.789278ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:09:22.816729Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":991526733697007559,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-12T02:09:23.027104Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.095060007s","expected-duration":"1s"}
{"level":"info","ts":"2026-02-12T02:09:23.036009Z","caller":"traceutil/trace.go:171","msg":"trace[524057245] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"1.104011262s","start":"2026-02-12T02:09:21.931981Z","end":"2026-02-12T02:09:23.035993Z","steps":["trace[524057245] 'process raft request'  (duration: 1.095317621s)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:09:23.036135Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:09:21.931968Z","time spent":"1.104106893s","remote":"127.0.0.1:43028","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:541 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-02-12T02:09:24.316444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000399205s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-02-12T02:09:24.316509Z","caller":"traceutil/trace.go:171","msg":"trace[428014385] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000475086s","start":"2026-02-12T02:09:22.31602Z","end":"2026-02-12T02:09:24.316495Z","steps":["trace[428014385] 'agreement among raft nodes before linearized reading'  (duration: 2.000396855s)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:09:24.316539Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:09:22.315967Z","time spent":"2.000566468s","remote":"127.0.0.1:42750","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-12T02:09:24.367241Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.339348849s","expected-duration":"1s"}
{"level":"warn","ts":"2026-02-12T02:09:26.321361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000052634s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-02-12T02:09:26.321456Z","caller":"traceutil/trace.go:171","msg":"trace[37286199] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000174657s","start":"2026-02-12T02:09:24.321259Z","end":"2026-02-12T02:09:26.321434Z","steps":["trace[37286199] 'agreement among raft nodes before linearized reading'  (duration: 2.000057015s)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:09:26.321514Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:09:24.321254Z","time spent":"2.000247748s","remote":"127.0.0.1:42760","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-12T02:09:26.996117Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.628747043s","expected-duration":"1s"}
{"level":"warn","ts":"2026-02-12T02:09:27.118485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:09:26.444704Z","time spent":"673.776458ms","remote":"127.0.0.1:36076","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"warn","ts":"2026-02-12T02:09:27.11891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.751524153s","expected-duration":"100ms","prefix":"","request":"header:<ID:991526733697007561 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:540 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-12T02:09:27.120498Z","caller":"traceutil/trace.go:171","msg":"trace[271430861] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"5.185239355s","start":"2026-02-12T02:09:21.93518Z","end":"2026-02-12T02:09:27.120419Z","steps":["trace[271430861] 'process raft request'  (duration: 2.432165583s)","trace[271430861] 'compare'  (duration: 2.750528336s)"],"step_count":2}
{"level":"info","ts":"2026-02-12T02:09:27.122346Z","caller":"traceutil/trace.go:171","msg":"trace[1901137159] linearizableReadLoop","detail":"{readStateIndex:571; appliedIndex:567; }","duration":"4.806294552s","start":"2026-02-12T02:09:22.316041Z","end":"2026-02-12T02:09:27.122336Z","steps":["trace[1901137159] 'read index received'  (duration: 711.266864ms)","trace[1901137159] 'applied index is now lower than readState.Index'  (duration: 4.095026478s)"],"step_count":2}
{"level":"warn","ts":"2026-02-12T02:09:27.122521Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:09:21.935171Z","time spent":"5.185448678s","remote":"127.0.0.1:43028","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:540 > 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-12T02:09:27.122607Z","caller":"traceutil/trace.go:171","msg":"trace[1538230705] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"5.187358653s","start":"2026-02-12T02:09:21.935239Z","end":"2026-02-12T02:09:27.122597Z","steps":["trace[1538230705] 'process raft request'  (duration: 5.183709697s)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:09:27.122821Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:09:21.935235Z","time spent":"5.187540536s","remote":"127.0.0.1:43028","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:539 > 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-12T02:09:27.122635Z","caller":"traceutil/trace.go:171","msg":"trace[1372953351] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"5.183196995s","start":"2026-02-12T02:09:21.939432Z","end":"2026-02-12T02:09:27.122629Z","steps":["trace[1372953351] 'process raft request'  (duration: 5.179540618s)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:09:27.123361Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:09:21.939423Z","time spent":"5.183912697s","remote":"127.0.0.1:42938","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16803,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-zkgf8\" mod_revision:463 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-zkgf8\" value_size:16754 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-zkgf8\" > >"}
{"level":"warn","ts":"2026-02-12T02:09:27.225878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.831456ms","expected-duration":"100ms","prefix":"","request":"header:<ID:991526733697007564 > lease_revoke:<id:0dc29c4f9b503f7a>","response":"size:28"}
{"level":"info","ts":"2026-02-12T02:09:27.226019Z","caller":"traceutil/trace.go:171","msg":"trace[111055590] linearizableReadLoop","detail":"{readStateIndex:573; appliedIndex:571; }","duration":"103.343813ms","start":"2026-02-12T02:09:27.122665Z","end":"2026-02-12T02:09:27.226009Z","steps":["trace[111055590] 'read index received'  (duration: 76.242µs)","trace[111055590] 'applied index is now lower than readState.Index'  (duration: 103.267021ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-12T02:09:27.226104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.294072438s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-02-12T02:09:27.226116Z","caller":"traceutil/trace.go:171","msg":"trace[1831833817] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:550; }","duration":"3.294123139s","start":"2026-02-12T02:09:23.931989Z","end":"2026-02-12T02:09:27.226112Z","steps":["trace[1831833817] 'agreement among raft nodes before linearized reading'  (duration: 3.294048307s)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:09:27.226132Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:09:23.931971Z","time spent":"3.29415717s","remote":"127.0.0.1:43028","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-02-12T02:09:27.226334Z","caller":"traceutil/trace.go:171","msg":"trace[114368916] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"2.757681635s","start":"2026-02-12T02:09:24.468646Z","end":"2026-02-12T02:09:27.226328Z","steps":["trace[114368916] 'process raft request'  (duration: 2.757297789s)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:09:27.226381Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:09:24.468629Z","time spent":"2.757719986s","remote":"127.0.0.1:43028","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:526 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"warn","ts":"2026-02-12T02:09:27.537918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"670.436955ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-12T02:09:27.537993Z","caller":"traceutil/trace.go:171","msg":"trace[1435955373] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:550; }","duration":"670.545526ms","start":"2026-02-12T02:09:26.867429Z","end":"2026-02-12T02:09:27.537974Z","steps":["trace[1435955373] 'agreement among raft nodes before linearized reading'  (duration: 358.88225ms)","trace[1435955373] 'count revisions from in-memory index tree'  (duration: 311.558905ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-12T02:09:27.538034Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:09:26.867416Z","time spent":"670.608658ms","remote":"127.0.0.1:43146","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":30,"request content":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true "}
{"level":"warn","ts":"2026-02-12T02:09:27.53843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.499440368s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-02-12T02:09:27.538469Z","caller":"traceutil/trace.go:171","msg":"trace[1980052705] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:550; }","duration":"2.49950348s","start":"2026-02-12T02:09:25.038953Z","end":"2026-02-12T02:09:27.538456Z","steps":["trace[1980052705] 'agreement among raft nodes before linearized reading'  (duration: 2.187542908s)","trace[1980052705] 'range keys from in-memory index tree'  (duration: 311.8386ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-12T02:09:27.538498Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:09:25.038939Z","time spent":"2.499552441s","remote":"127.0.0.1:43028","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-02-12T02:09:27.538617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.215954293s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-12T02:09:27.538642Z","caller":"traceutil/trace.go:171","msg":"trace[2111248252] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:550; }","duration":"1.216004134s","start":"2026-02-12T02:09:26.322629Z","end":"2026-02-12T02:09:27.538633Z","steps":["trace[2111248252] 'agreement among raft nodes before linearized reading'  (duration: 903.871599ms)","trace[2111248252] 'range keys from in-memory index tree'  (duration: 312.103545ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-12T02:09:27.538667Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:09:26.322618Z","time spent":"1.216043675s","remote":"127.0.0.1:42750","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-12T02:09:27.538821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.2189042s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/kube-apiserver-instance.18935dbf719ff4cf\" ","response":"range_response_count:1 size:774"}
{"level":"info","ts":"2026-02-12T02:09:27.538852Z","caller":"traceutil/trace.go:171","msg":"trace[379696185] range","detail":"{range_begin:/registry/events/kube-system/kube-apiserver-instance.18935dbf719ff4cf; range_end:; response_count:1; response_revision:550; }","duration":"3.218949631s","start":"2026-02-12T02:09:24.319893Z","end":"2026-02-12T02:09:27.538842Z","steps":["trace[379696185] 'agreement among raft nodes before linearized reading'  (duration: 2.906612352s)","trace[379696185] 'range keys from in-memory index tree'  (duration: 312.266398ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-12T02:09:27.538878Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:09:24.319883Z","time spent":"3.218989291s","remote":"127.0.0.1:42854","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":797,"request content":"key:\"/registry/events/kube-system/kube-apiserver-instance.18935dbf719ff4cf\" "}
{"level":"info","ts":"2026-02-12T02:09:27.539196Z","caller":"traceutil/trace.go:171","msg":"trace[1657714579] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"308.606382ms","start":"2026-02-12T02:09:27.230574Z","end":"2026-02-12T02:09:27.539181Z","steps":["trace[1657714579] 'process raft request'  (duration: 217.951247ms)","trace[1657714579] 'compare'  (duration: 90.559713ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-12T02:09:27.539274Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:09:27.230556Z","time spent":"308.668013ms","remote":"127.0.0.1:43028","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:545 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-02-12T02:09:27.900813Z","caller":"traceutil/trace.go:171","msg":"trace[615836810] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"351.055243ms","start":"2026-02-12T02:09:27.549737Z","end":"2026-02-12T02:09:27.900792Z","steps":["trace[615836810] 'process raft request'  (duration: 350.91461ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:09:27.900948Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:09:27.549722Z","time spent":"351.149235ms","remote":"127.0.0.1:43028","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:546 > 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-12T02:09:27.907067Z","caller":"traceutil/trace.go:171","msg":"trace[1655033814] linearizableReadLoop","detail":"{readStateIndex:576; appliedIndex:574; }","duration":"353.73855ms","start":"2026-02-12T02:09:27.553313Z","end":"2026-02-12T02:09:27.907052Z","steps":["trace[1655033814] 'read index received'  (duration: 347.369466ms)","trace[1655033814] 'applied index is now lower than readState.Index'  (duration: 6.368134ms)"],"step_count":2}
{"level":"info","ts":"2026-02-12T02:09:27.907093Z","caller":"traceutil/trace.go:171","msg":"trace[72119345] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"354.23856ms","start":"2026-02-12T02:09:27.552833Z","end":"2026-02-12T02:09:27.907072Z","steps":["trace[72119345] 'process raft request'  (duration: 354.138258ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:09:27.907193Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:09:27.552826Z","time spent":"354.310732ms","remote":"127.0.0.1:42854","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.18935dbf719ff4cf\" mod_revision:527 > success:<request_put:<key:\"/registry/events/kube-system/kube-apiserver-instance.18935dbf719ff4cf\" value_size:672 lease:991526733697006844 >> failure:<request_range:<key:\"/registry/events/kube-system/kube-apiserver-instance.18935dbf719ff4cf\" > >"}
{"level":"warn","ts":"2026-02-12T02:09:27.90721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.886613ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-12T02:09:27.907246Z","caller":"traceutil/trace.go:171","msg":"trace[292686513] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:553; }","duration":"353.924483ms","start":"2026-02-12T02:09:27.55331Z","end":"2026-02-12T02:09:27.907234Z","steps":["trace[292686513] 'agreement among raft nodes before linearized reading'  (duration: 353.824872ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:09:27.907275Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:09:27.553289Z","time spent":"353.979855ms","remote":"127.0.0.1:42760","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-12T02:09:29.016893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"686.0655ms","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-12T02:09:29.017Z","caller":"traceutil/trace.go:171","msg":"trace[1169803941] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:558; }","duration":"686.184372ms","start":"2026-02-12T02:09:28.3308Z","end":"2026-02-12T02:09:29.016984Z","steps":["trace[1169803941] 'range keys from in-memory index tree'  (duration: 686.0516ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:09:29.01743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"416.996272ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.141\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-02-12T02:09:29.017462Z","caller":"traceutil/trace.go:171","msg":"trace[1085057840] range","detail":"{range_begin:/registry/masterleases/199.204.45.141; range_end:; response_count:1; response_revision:558; }","duration":"417.059982ms","start":"2026-02-12T02:09:28.600392Z","end":"2026-02-12T02:09:29.017452Z","steps":["trace[1085057840] 'range keys from in-memory index tree'  (duration: 416.817978ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:09:29.017495Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:09:28.600378Z","time spent":"417.109704ms","remote":"127.0.0.1:42800","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.141\" "}
{"level":"warn","ts":"2026-02-12T02:09:29.017821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.477736ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-zkgf8\" ","response":"range_response_count:1 size:16916"}
{"level":"info","ts":"2026-02-12T02:09:29.017849Z","caller":"traceutil/trace.go:171","msg":"trace[1699455336] range","detail":"{range_begin:/registry/pods/kube-system/cilium-zkgf8; range_end:; response_count:1; response_revision:558; }","duration":"173.539127ms","start":"2026-02-12T02:09:28.844301Z","end":"2026-02-12T02:09:29.01784Z","steps":["trace[1699455336] 'range keys from in-memory index tree'  (duration: 173.356925ms)"],"step_count":1}
{"level":"info","ts":"2026-02-12T02:09:29.3723Z","caller":"traceutil/trace.go:171","msg":"trace[2028102553] transaction","detail":"{read_only:false; response_revision:559; number_of_response:1; }","duration":"341.657089ms","start":"2026-02-12T02:09:29.030624Z","end":"2026-02-12T02:09:29.372281Z","steps":["trace[2028102553] 'process raft request'  (duration: 341.294143ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:09:29.372416Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:09:29.030607Z","time spent":"341.746951ms","remote":"127.0.0.1:42938","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17063,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-zkgf8\" mod_revision:555 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-zkgf8\" value_size:17014 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-zkgf8\" > >"}
{"level":"info","ts":"2026-02-12T02:09:29.382595Z","caller":"traceutil/trace.go:171","msg":"trace[1734380865] linearizableReadLoop","detail":"{readStateIndex:584; appliedIndex:582; }","duration":"255.899042ms","start":"2026-02-12T02:09:29.12668Z","end":"2026-02-12T02:09:29.382579Z","steps":["trace[1734380865] 'read index received'  (duration: 245.246545ms)","trace[1734380865] 'applied index is now lower than readState.Index'  (duration: 10.651957ms)"],"step_count":2}
{"level":"info","ts":"2026-02-12T02:09:29.382677Z","caller":"traceutil/trace.go:171","msg":"trace[260450874] transaction","detail":"{read_only:false; response_revision:561; number_of_response:1; }","duration":"202.670123ms","start":"2026-02-12T02:09:29.180002Z","end":"2026-02-12T02:09:29.382672Z","steps":["trace[260450874] 'process raft request'  (duration: 202.55007ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:09:29.38289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.197139ms","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-12T02:09:29.38291Z","caller":"traceutil/trace.go:171","msg":"trace[195629674] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:561; }","duration":"256.27199ms","start":"2026-02-12T02:09:29.126633Z","end":"2026-02-12T02:09:29.382905Z","steps":["trace[195629674] 'agreement among raft nodes before linearized reading'  (duration: 256.189079ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:09:29.382995Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.440826ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-02-12T02:09:29.383014Z","caller":"traceutil/trace.go:171","msg":"trace[448016667] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:561; }","duration":"255.473937ms","start":"2026-02-12T02:09:29.127536Z","end":"2026-02-12T02:09:29.38301Z","steps":["trace[448016667] 'agreement among raft nodes before linearized reading'  (duration: 255.433766ms)"],"step_count":1}
{"level":"info","ts":"2026-02-12T02:09:29.383302Z","caller":"traceutil/trace.go:171","msg":"trace[951961738] transaction","detail":"{read_only:false; response_revision:560; number_of_response:1; }","duration":"317.987881ms","start":"2026-02-12T02:09:29.065308Z","end":"2026-02-12T02:09:29.383296Z","steps":["trace[951961738] 'process raft request'  (duration: 317.142975ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:09:29.383355Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:09:29.065255Z","time spent":"318.064182ms","remote":"127.0.0.1:42800","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.141\" mod_revision:536 > success:<request_put:<key:\"/registry/masterleases/199.204.45.141\" value_size:67 lease:991526733697007582 >> failure:<request_range:<key:\"/registry/masterleases/199.204.45.141\" > >"}
{"level":"info","ts":"2026-02-12T02:09:30.367267Z","caller":"traceutil/trace.go:171","msg":"trace[986662258] transaction","detail":"{read_only:false; response_revision:567; number_of_response:1; }","duration":"395.349064ms","start":"2026-02-12T02:09:29.971898Z","end":"2026-02-12T02:09:30.367247Z","steps":["trace[986662258] 'process raft request'  (duration: 387.450265ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:09:30.367384Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:09:29.97188Z","time spent":"395.439585ms","remote":"127.0.0.1:43028","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:552 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-02-12T02:09:32.001291Z","caller":"traceutil/trace.go:171","msg":"trace[1397175534] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"158.713476ms","start":"2026-02-12T02:09:31.842536Z","end":"2026-02-12T02:09:32.00125Z","steps":["trace[1397175534] 'process raft request'  (duration: 158.540593ms)"],"step_count":1}
{"level":"info","ts":"2026-02-12T02:09:32.002099Z","caller":"traceutil/trace.go:171","msg":"trace[1806792666] linearizableReadLoop","detail":"{readStateIndex:598; appliedIndex:598; }","duration":"147.006633ms","start":"2026-02-12T02:09:31.855079Z","end":"2026-02-12T02:09:32.002086Z","steps":["trace[1806792666] 'read index received'  (duration: 147.001833ms)","trace[1806792666] 'applied index is now lower than readState.Index'  (duration: 3.9µs)"],"step_count":2}
{"level":"info","ts":"2026-02-12T02:09:32.004944Z","caller":"traceutil/trace.go:171","msg":"trace[1781150378] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"148.920057ms","start":"2026-02-12T02:09:31.856005Z","end":"2026-02-12T02:09:32.004925Z","steps":["trace[1781150378] 'process raft request'  (duration: 148.838895ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:09:32.007721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.154656ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-zkgf8\" ","response":"range_response_count:1 size:17171"}
{"level":"info","ts":"2026-02-12T02:09:32.007844Z","caller":"traceutil/trace.go:171","msg":"trace[1000571382] range","detail":"{range_begin:/registry/pods/kube-system/cilium-zkgf8; range_end:; response_count:1; response_revision:573; }","duration":"152.763713ms","start":"2026-02-12T02:09:31.855057Z","end":"2026-02-12T02:09:32.007821Z","steps":["trace[1000571382] 'agreement among raft nodes before linearized reading'  (duration: 147.083254ms)"],"step_count":1}
{"level":"info","ts":"2026-02-12T02:09:33.611491Z","caller":"traceutil/trace.go:171","msg":"trace[1049838943] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"183.16505ms","start":"2026-02-12T02:09:33.42831Z","end":"2026-02-12T02:09:33.611475Z","steps":["trace[1049838943] 'process raft request'  (duration: 183.085028ms)"],"step_count":1}
{"level":"info","ts":"2026-02-12T02:09:33.61391Z","caller":"traceutil/trace.go:171","msg":"trace[1148159985] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"184.688957ms","start":"2026-02-12T02:09:33.429213Z","end":"2026-02-12T02:09:33.613902Z","steps":["trace[1148159985] 'process raft request'  (duration: 184.656546ms)"],"step_count":1}
{"level":"info","ts":"2026-02-12T02:09:34.518169Z","caller":"traceutil/trace.go:171","msg":"trace[1792885266] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"433.223613ms","start":"2026-02-12T02:09:34.084927Z","end":"2026-02-12T02:09:34.518151Z","steps":["trace[1792885266] 'process raft request'  (duration: 433.122691ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:09:34.518394Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:09:34.084897Z","time spent":"433.446896ms","remote":"127.0.0.1:42816","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4580,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io\" value_size:4482 >> failure:<>"}
{"level":"info","ts":"2026-02-12T02:09:34.518829Z","caller":"traceutil/trace.go:171","msg":"trace[1024653762] linearizableReadLoop","detail":"{readStateIndex:622; appliedIndex:622; }","duration":"406.77745ms","start":"2026-02-12T02:09:34.112044Z","end":"2026-02-12T02:09:34.518821Z","steps":["trace[1024653762] 'read index received'  (duration: 406.77233ms)","trace[1024653762] 'applied index is now lower than readState.Index'  (duration: 4.44µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-12T02:09:34.521722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"409.668099ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-12T02:09:34.521821Z","caller":"traceutil/trace.go:171","msg":"trace[1706876077] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io; range_end:; response_count:0; response_revision:596; }","duration":"409.772901ms","start":"2026-02-12T02:09:34.112013Z","end":"2026-02-12T02:09:34.521786Z","steps":["trace[1706876077] 'agreement among raft nodes before linearized reading'  (duration: 409.656589ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:09:34.52187Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:09:34.111999Z","time spent":"409.862933ms","remote":"127.0.0.1:42816","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" "}
{"level":"warn","ts":"2026-02-12T02:09:34.522148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"409.852463ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-12T02:09:34.522202Z","caller":"traceutil/trace.go:171","msg":"trace[286498038] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io; range_end:; response_count:0; response_revision:597; }","duration":"409.916344ms","start":"2026-02-12T02:09:34.112272Z","end":"2026-02-12T02:09:34.522188Z","steps":["trace[286498038] 'agreement among raft nodes before linearized reading'  (duration: 409.816222ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:09:34.522308Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:09:34.112232Z","time spent":"410.069276ms","remote":"127.0.0.1:42816","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io\" "}
{"level":"info","ts":"2026-02-12T02:09:34.522522Z","caller":"traceutil/trace.go:171","msg":"trace[1626819299] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"392.236601ms","start":"2026-02-12T02:09:34.130279Z","end":"2026-02-12T02:09:34.522515Z","steps":["trace[1626819299] 'process raft request'  (duration: 391.728113ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:09:34.522631Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:09:34.130262Z","time spent":"392.278693ms","remote":"127.0.0.1:43028","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:595 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:409 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-02-12T02:09:34.52288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.711701ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-02-12T02:09:34.5229Z","caller":"traceutil/trace.go:171","msg":"trace[60534254] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:597; }","duration":"144.757333ms","start":"2026-02-12T02:09:34.378138Z","end":"2026-02-12T02:09:34.522895Z","steps":["trace[60534254] 'agreement among raft nodes before linearized reading'  (duration: 144.689702ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:09:34.523049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.257887ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-12T02:09:34.523068Z","caller":"traceutil/trace.go:171","msg":"trace[1032088655] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:597; }","duration":"208.297639ms","start":"2026-02-12T02:09:34.314766Z","end":"2026-02-12T02:09:34.523064Z","steps":["trace[1032088655] 'agreement among raft nodes before linearized reading'  (duration: 208.268968ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:09:34.523315Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.468926ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-12T02:09:34.523335Z","caller":"traceutil/trace.go:171","msg":"trace[2146616991] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:597; }","duration":"265.541647ms","start":"2026-02-12T02:09:34.257789Z","end":"2026-02-12T02:09:34.523331Z","steps":["trace[2146616991] 'agreement among raft nodes before linearized reading'  (duration: 265.511107ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:09:34.523611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"394.736695ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-12T02:09:34.523633Z","caller":"traceutil/trace.go:171","msg":"trace[878527452] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io; range_end:; response_count:0; response_revision:597; }","duration":"394.777955ms","start":"2026-02-12T02:09:34.12885Z","end":"2026-02-12T02:09:34.523628Z","steps":["trace[878527452] 'agreement among raft nodes before linearized reading'  (duration: 394.576902ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:09:34.525373Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:09:34.128842Z","time spent":"396.523404ms","remote":"127.0.0.1:42816","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" "}
{"level":"warn","ts":"2026-02-12T02:09:34.525493Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"400.368321ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-12T02:09:34.525528Z","caller":"traceutil/trace.go:171","msg":"trace[1831881411] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io; range_end:; response_count:0; response_revision:597; }","duration":"400.430282ms","start":"2026-02-12T02:09:34.125093Z","end":"2026-02-12T02:09:34.525523Z","steps":["trace[1831881411] 'agreement among raft nodes before linearized reading'  (duration: 400.371071ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:09:34.525544Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:09:34.125078Z","time spent":"400.462812ms","remote":"127.0.0.1:42816","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" "}
{"level":"warn","ts":"2026-02-12T02:09:34.525961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"403.887242ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-12T02:09:34.525984Z","caller":"traceutil/trace.go:171","msg":"trace[487550442] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io; range_end:; response_count:0; response_revision:597; }","duration":"403.920972ms","start":"2026-02-12T02:09:34.122056Z","end":"2026-02-12T02:09:34.525977Z","steps":["trace[487550442] 'agreement among raft nodes before linearized reading'  (duration: 403.886932ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:09:34.525997Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:09:34.122048Z","time spent":"403.946293ms","remote":"127.0.0.1:42816","response type":"/etcdserverpb.KV/Range","request count":0,"request size":84,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" "}
{"level":"warn","ts":"2026-02-12T02:09:34.526034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"409.305244ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-12T02:09:34.526046Z","caller":"traceutil/trace.go:171","msg":"trace[1939571950] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io; range_end:; response_count:0; response_revision:597; }","duration":"409.322995ms","start":"2026-02-12T02:09:34.116718Z","end":"2026-02-12T02:09:34.526041Z","steps":["trace[1939571950] 'agreement among raft nodes before linearized reading'  (duration: 409.306454ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:09:34.526208Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:09:34.116715Z","time spent":"409.485377ms","remote":"127.0.0.1:42816","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" "}
{"level":"warn","ts":"2026-02-12T02:09:34.526739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"410.074877ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-02-12T02:09:34.527826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"411.194126ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-12T02:09:34.527848Z","caller":"traceutil/trace.go:171","msg":"trace[961182608] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io; range_end:; response_count:0; response_revision:597; }","duration":"411.234227ms","start":"2026-02-12T02:09:34.116609Z","end":"2026-02-12T02:09:34.527844Z","steps":["trace[961182608] 'agreement among raft nodes before linearized reading'  (duration: 411.199236ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:09:34.532292Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:09:34.116599Z","time spent":"415.683003ms","remote":"127.0.0.1:42816","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" "}
{"level":"info","ts":"2026-02-12T02:09:34.526769Z","caller":"traceutil/trace.go:171","msg":"trace[2045672919] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io; range_end:; response_count:0; response_revision:597; }","duration":"410.125459ms","start":"2026-02-12T02:09:34.116636Z","end":"2026-02-12T02:09:34.526762Z","steps":["trace[2045672919] 'agreement among raft nodes before linearized reading'  (duration: 410.085978ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:09:34.532503Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:09:34.116633Z","time spent":"415.863837ms","remote":"127.0.0.1:42816","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io\" "}
{"level":"info","ts":"2026-02-12T02:09:36.168491Z","caller":"traceutil/trace.go:171","msg":"trace[186841299] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"174.029045ms","start":"2026-02-12T02:09:35.99444Z","end":"2026-02-12T02:09:36.168469Z","steps":["trace[186841299] 'process raft request'  (duration: 137.647782ms)","trace[186841299] 'compare'  (duration: 36.19329ms)"],"step_count":2}
{"level":"info","ts":"2026-02-12T02:09:36.196865Z","caller":"traceutil/trace.go:171","msg":"trace[1966582274] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"135.601556ms","start":"2026-02-12T02:09:36.061245Z","end":"2026-02-12T02:09:36.196846Z","steps":["trace[1966582274] 'process raft request'  (duration: 135.506005ms)"],"step_count":1}
{"level":"info","ts":"2026-02-12T02:09:36.197066Z","caller":"traceutil/trace.go:171","msg":"trace[1853927704] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"150.855654ms","start":"2026-02-12T02:09:36.046206Z","end":"2026-02-12T02:09:36.197061Z","steps":["trace[1853927704] 'process raft request'  (duration: 149.340109ms)"],"step_count":1}
{"level":"info","ts":"2026-02-12T02:09:38.441156Z","caller":"traceutil/trace.go:171","msg":"trace[1330531682] linearizableReadLoop","detail":"{readStateIndex:694; appliedIndex:693; }","duration":"185.956095ms","start":"2026-02-12T02:09:38.255179Z","end":"2026-02-12T02:09:38.441135Z","steps":["trace[1330531682] 'read index received'  (duration: 158.050991ms)","trace[1330531682] 'applied index is now lower than readState.Index'  (duration: 27.903984ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-12T02:09:38.44134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.208164ms","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-12T02:09:38.441516Z","caller":"traceutil/trace.go:171","msg":"trace[994960495] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:667; }","duration":"110.403167ms","start":"2026-02-12T02:09:38.331093Z","end":"2026-02-12T02:09:38.441496Z","steps":["trace[994960495] 'range keys from in-memory index tree'  (duration: 110.107312ms)"],"step_count":1}
{"level":"info","ts":"2026-02-12T02:09:38.441865Z","caller":"traceutil/trace.go:171","msg":"trace[256469400] transaction","detail":"{read_only:false; number_of_response:0; response_revision:667; }","duration":"208.442089ms","start":"2026-02-12T02:09:38.233368Z","end":"2026-02-12T02:09:38.44181Z","steps":["trace[256469400] 'process raft request'  (duration: 179.818413ms)","trace[256469400] 'compare'  (duration: 27.900304ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-12T02:09:38.442293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.777286ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" ","response":"range_response_count:1 size:4083"}
{"level":"info","ts":"2026-02-12T02:09:38.442567Z","caller":"traceutil/trace.go:171","msg":"trace[1565538757] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io; range_end:; response_count:1; response_revision:667; }","duration":"185.06613ms","start":"2026-02-12T02:09:38.257481Z","end":"2026-02-12T02:09:38.442547Z","steps":["trace[1565538757] 'agreement among raft nodes before linearized reading'  (duration: 184.693493ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:09:38.442886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.700845ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/instance\" ","response":"range_response_count:1 size:1668"}
{"level":"info","ts":"2026-02-12T02:09:38.443026Z","caller":"traceutil/trace.go:171","msg":"trace[1826395327] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/instance; range_end:; response_count:1; response_revision:667; }","duration":"187.928188ms","start":"2026-02-12T02:09:38.255086Z","end":"2026-02-12T02:09:38.443014Z","steps":["trace[1826395327] 'agreement among raft nodes before linearized reading'  (duration: 187.759255ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:09:38.443441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.172466ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/kubeadm-config\" ","response":"range_response_count:1 size:1000"}
{"level":"info","ts":"2026-02-12T02:09:38.443545Z","caller":"traceutil/trace.go:171","msg":"trace[753499508] range","detail":"{range_begin:/registry/configmaps/kube-system/kubeadm-config; range_end:; response_count:1; response_revision:667; }","duration":"157.288477ms","start":"2026-02-12T02:09:38.286247Z","end":"2026-02-12T02:09:38.443535Z","steps":["trace[753499508] 'agreement among raft nodes before linearized reading'  (duration: 157.156045ms)"],"step_count":1}
{"level":"info","ts":"2026-02-12T02:09:45.124986Z","caller":"traceutil/trace.go:171","msg":"trace[1591771226] transaction","detail":"{read_only:false; response_revision:715; number_of_response:1; }","duration":"100.35745ms","start":"2026-02-12T02:09:45.024612Z","end":"2026-02-12T02:09:45.124969Z","steps":["trace[1591771226] 'process raft request'  (duration: 99.201452ms)"],"step_count":1}
{"level":"info","ts":"2026-02-12T02:09:45.261851Z","caller":"traceutil/trace.go:171","msg":"trace[20901203] transaction","detail":"{read_only:false; response_revision:719; number_of_response:1; }","duration":"126.526146ms","start":"2026-02-12T02:09:45.13531Z","end":"2026-02-12T02:09:45.261836Z","steps":["trace[20901203] 'process raft request'  (duration: 126.473516ms)"],"step_count":1}
{"level":"info","ts":"2026-02-12T02:09:45.261884Z","caller":"traceutil/trace.go:171","msg":"trace[255532712] transaction","detail":"{read_only:false; response_revision:718; number_of_response:1; }","duration":"128.018721ms","start":"2026-02-12T02:09:45.13383Z","end":"2026-02-12T02:09:45.261849Z","steps":["trace[255532712] 'process raft request'  (duration: 120.572372ms)"],"step_count":1}
{"level":"info","ts":"2026-02-12T02:09:45.457232Z","caller":"traceutil/trace.go:171","msg":"trace[1399907888] transaction","detail":"{read_only:false; response_revision:723; number_of_response:1; }","duration":"180.294765ms","start":"2026-02-12T02:09:45.276921Z","end":"2026-02-12T02:09:45.457216Z","steps":["trace[1399907888] 'process raft request'  (duration: 126.146051ms)","trace[1399907888] 'compare'  (duration: 54.021182ms)"],"step_count":2}
{"level":"info","ts":"2026-02-12T02:09:45.457333Z","caller":"traceutil/trace.go:171","msg":"trace[2048507594] transaction","detail":"{read_only:false; response_revision:724; number_of_response:1; }","duration":"173.77248ms","start":"2026-02-12T02:09:45.283556Z","end":"2026-02-12T02:09:45.457329Z","steps":["trace[2048507594] 'process raft request'  (duration: 173.603347ms)"],"step_count":1}
{"level":"info","ts":"2026-02-12T02:09:45.457507Z","caller":"traceutil/trace.go:171","msg":"trace[1652418272] linearizableReadLoop","detail":"{readStateIndex:754; appliedIndex:751; }","duration":"142.291939ms","start":"2026-02-12T02:09:45.315202Z","end":"2026-02-12T02:09:45.457494Z","steps":["trace[1652418272] 'read index received'  (duration: 16.514813ms)","trace[1652418272] 'applied index is now lower than readState.Index'  (duration: 125.775946ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-12T02:09:45.457571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.35971ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-12T02:09:45.457595Z","caller":"traceutil/trace.go:171","msg":"trace[549999402] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:725; }","duration":"142.421181ms","start":"2026-02-12T02:09:45.315167Z","end":"2026-02-12T02:09:45.457588Z","steps":["trace[549999402] 'agreement among raft nodes before linearized reading'  (duration: 142.36858ms)"],"step_count":1}
{"level":"info","ts":"2026-02-12T02:09:45.45765Z","caller":"traceutil/trace.go:171","msg":"trace[620965862] transaction","detail":"{read_only:false; response_revision:725; number_of_response:1; }","duration":"171.963032ms","start":"2026-02-12T02:09:45.285682Z","end":"2026-02-12T02:09:45.457645Z","steps":["trace[620965862] 'process raft request'  (duration: 171.509605ms)"],"step_count":1}
{"level":"info","ts":"2026-02-12T02:09:45.813932Z","caller":"traceutil/trace.go:171","msg":"trace[855342848] transaction","detail":"{read_only:false; response_revision:726; number_of_response:1; }","duration":"341.158159ms","start":"2026-02-12T02:09:45.472755Z","end":"2026-02-12T02:09:45.813913Z","steps":["trace[855342848] 'process raft request'  (duration: 341.053797ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:09:45.814044Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:09:45.472738Z","time spent":"341.2485ms","remote":"127.0.0.1:43248","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3866,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/replicasets/kube-system/coredns-77cccfdc44\" mod_revision:724 > success:<request_put:<key:\"/registry/replicasets/kube-system/coredns-77cccfdc44\" value_size:3806 >> failure:<request_range:<key:\"/registry/replicasets/kube-system/coredns-77cccfdc44\" > >"}
{"level":"info","ts":"2026-02-12T02:09:46.059081Z","caller":"traceutil/trace.go:171","msg":"trace[305956947] linearizableReadLoop","detail":"{readStateIndex:758; appliedIndex:755; }","duration":"254.724274ms","start":"2026-02-12T02:09:45.804338Z","end":"2026-02-12T02:09:46.059062Z","steps":["trace[305956947] 'read index received'  (duration: 10.05985ms)","trace[305956947] 'applied index is now lower than readState.Index'  (duration: 244.663654ms)"],"step_count":2}
{"level":"info","ts":"2026-02-12T02:09:46.059286Z","caller":"traceutil/trace.go:171","msg":"trace[1603422460] transaction","detail":"{read_only:false; response_revision:727; number_of_response:1; }","duration":"584.707446ms","start":"2026-02-12T02:09:45.474566Z","end":"2026-02-12T02:09:46.059274Z","steps":["trace[1603422460] 'process raft request'  (duration: 524.034134ms)","trace[1603422460] 'compare'  (duration: 59.96051ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-12T02:09:46.059357Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:09:45.474557Z","time spent":"584.750057ms","remote":"127.0.0.1:42932","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1019,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/services/endpoints/kube-system/kube-dns\" mod_revision:723 > success:<request_put:<key:\"/registry/services/endpoints/kube-system/kube-dns\" value_size:962 >> failure:<request_range:<key:\"/registry/services/endpoints/kube-system/kube-dns\" > >"}
{"level":"info","ts":"2026-02-12T02:09:46.059547Z","caller":"traceutil/trace.go:171","msg":"trace[449608985] transaction","detail":"{read_only:false; response_revision:728; number_of_response:1; }","duration":"584.091196ms","start":"2026-02-12T02:09:45.475448Z","end":"2026-02-12T02:09:46.05954Z","steps":["trace[449608985] 'process raft request'  (duration: 583.515076ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:09:46.059581Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:09:45.475437Z","time spent":"584.125237ms","remote":"127.0.0.1:43248","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3830,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/replicasets/kube-system/coredns-5dd5756b68\" mod_revision:719 > success:<request_put:<key:\"/registry/replicasets/kube-system/coredns-5dd5756b68\" value_size:3770 >> failure:<request_range:<key:\"/registry/replicasets/kube-system/coredns-5dd5756b68\" > >"}
{"level":"info","ts":"2026-02-12T02:09:46.059719Z","caller":"traceutil/trace.go:171","msg":"trace[422121829] transaction","detail":"{read_only:false; response_revision:729; number_of_response:1; }","duration":"583.768491ms","start":"2026-02-12T02:09:45.475945Z","end":"2026-02-12T02:09:46.059713Z","steps":["trace[422121829] 'process raft request'  (duration: 583.076169ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:09:46.062435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.085488ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"warn","ts":"2026-02-12T02:09:46.062921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.146722ms","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-12T02:09:46.064625Z","caller":"traceutil/trace.go:171","msg":"trace[2119734253] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:729; }","duration":"240.283915ms","start":"2026-02-12T02:09:45.822715Z","end":"2026-02-12T02:09:46.062999Z","steps":["trace[2119734253] 'agreement among raft nodes before linearized reading'  (duration: 240.023131ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:09:46.064949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.567739ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-02-12T02:09:46.064978Z","caller":"traceutil/trace.go:171","msg":"trace[426168108] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:729; }","duration":"144.6248ms","start":"2026-02-12T02:09:45.920346Z","end":"2026-02-12T02:09:46.06497Z","steps":["trace[426168108] 'agreement among raft nodes before linearized reading'  (duration: 144.544779ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:09:46.062758Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:09:45.475938Z","time spent":"583.796211ms","remote":"127.0.0.1:43044","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1614,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/endpointslices/kube-system/kube-dns-s2lkv\" mod_revision:722 > success:<request_put:<key:\"/registry/endpointslices/kube-system/kube-dns-s2lkv\" value_size:1555 >> failure:<request_range:<key:\"/registry/endpointslices/kube-system/kube-dns-s2lkv\" > >"}
{"level":"info","ts":"2026-02-12T02:09:46.062984Z","caller":"traceutil/trace.go:171","msg":"trace[43158039] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:729; }","duration":"258.661347ms","start":"2026-02-12T02:09:45.804313Z","end":"2026-02-12T02:09:46.062974Z","steps":["trace[43158039] 'agreement among raft nodes before linearized reading'  (duration: 258.028458ms)"],"step_count":1}
{"level":"info","ts":"2026-02-12T02:09:46.282686Z","caller":"traceutil/trace.go:171","msg":"trace[2032038423] linearizableReadLoop","detail":"{readStateIndex:764; appliedIndex:762; }","duration":"110.957388ms","start":"2026-02-12T02:09:46.171712Z","end":"2026-02-12T02:09:46.282669Z","steps":["trace[2032038423] 'read index received'  (duration: 33.44875ms)","trace[2032038423] 'applied index is now lower than readState.Index'  (duration: 77.508078ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-12T02:09:46.282878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.14699ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:4206"}
{"level":"info","ts":"2026-02-12T02:09:46.282912Z","caller":"traceutil/trace.go:171","msg":"trace[327340735] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:735; }","duration":"111.214582ms","start":"2026-02-12T02:09:46.17169Z","end":"2026-02-12T02:09:46.282904Z","steps":["trace[327340735] 'agreement among raft nodes before linearized reading'  (duration: 111.04909ms)"],"step_count":1}
{"level":"info","ts":"2026-02-12T02:09:46.283186Z","caller":"traceutil/trace.go:171","msg":"trace[2120324498] transaction","detail":"{read_only:false; response_revision:734; number_of_response:1; }","duration":"183.04711ms","start":"2026-02-12T02:09:46.100126Z","end":"2026-02-12T02:09:46.283173Z","steps":["trace[2120324498] 'process raft request'  (duration: 105.027855ms)","trace[2120324498] 'compare'  (duration: 77.395916ms)"],"step_count":2}
{"level":"info","ts":"2026-02-12T02:09:46.283385Z","caller":"traceutil/trace.go:171","msg":"trace[2075870378] transaction","detail":"{read_only:false; response_revision:735; number_of_response:1; }","duration":"134.138886ms","start":"2026-02-12T02:09:46.14924Z","end":"2026-02-12T02:09:46.283379Z","steps":["trace[2075870378] 'process raft request'  (duration: 133.396353ms)"],"step_count":1}
{"level":"info","ts":"2026-02-12T02:09:46.857407Z","caller":"traceutil/trace.go:171","msg":"trace[1280760973] transaction","detail":"{read_only:false; response_revision:744; number_of_response:1; }","duration":"136.35574ms","start":"2026-02-12T02:09:46.721033Z","end":"2026-02-12T02:09:46.857389Z","steps":["trace[1280760973] 'process raft request'  (duration: 52.901489ms)","trace[1280760973] 'compare'  (duration: 83.38ms)"],"step_count":2}
{"level":"info","ts":"2026-02-12T02:09:47.92949Z","caller":"traceutil/trace.go:171","msg":"trace[1769957026] linearizableReadLoop","detail":"{readStateIndex:774; appliedIndex:773; }","duration":"285.248254ms","start":"2026-02-12T02:09:47.644224Z","end":"2026-02-12T02:09:47.929473Z","steps":["trace[1769957026] 'read index received'  (duration: 285.065241ms)","trace[1769957026] 'applied index is now lower than readState.Index'  (duration: 182.213µs)"],"step_count":2}
{"level":"info","ts":"2026-02-12T02:09:47.929736Z","caller":"traceutil/trace.go:171","msg":"trace[1497068426] transaction","detail":"{read_only:false; response_revision:745; number_of_response:1; }","duration":"429.300343ms","start":"2026-02-12T02:09:47.500423Z","end":"2026-02-12T02:09:47.929723Z","steps":["trace[1497068426] 'process raft request'  (duration: 428.912487ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:09:47.929844Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:09:47.500411Z","time spent":"429.360254ms","remote":"127.0.0.1:43028","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:662 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"warn","ts":"2026-02-12T02:09:47.930015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.794812ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-12T02:09:47.930047Z","caller":"traceutil/trace.go:171","msg":"trace[1215814349] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:745; }","duration":"285.858323ms","start":"2026-02-12T02:09:47.644178Z","end":"2026-02-12T02:09:47.930036Z","steps":["trace[1215814349] 'agreement among raft nodes before linearized reading'  (duration: 285.809662ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:10:45.539601Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.58149ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-12T02:10:45.539656Z","caller":"traceutil/trace.go:171","msg":"trace[423481149] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:957; }","duration":"225.669492ms","start":"2026-02-12T02:10:45.313976Z","end":"2026-02-12T02:10:45.539645Z","steps":["trace[423481149] 'range keys from in-memory index tree'  (duration: 225.53059ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:10:45.539805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.53542ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-02-12T02:10:45.539822Z","caller":"traceutil/trace.go:171","msg":"trace[2085395330] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:957; }","duration":"167.58596ms","start":"2026-02-12T02:10:45.372231Z","end":"2026-02-12T02:10:45.539817Z","steps":["trace[2085395330] 'range keys from in-memory index tree'  (duration: 167.427028ms)"],"step_count":1}
{"level":"info","ts":"2026-02-12T02:10:47.187955Z","caller":"traceutil/trace.go:171","msg":"trace[1194074585] linearizableReadLoop","detail":"{readStateIndex:1002; appliedIndex:1001; }","duration":"456.855289ms","start":"2026-02-12T02:10:46.73108Z","end":"2026-02-12T02:10:47.187935Z","steps":["trace[1194074585] 'read index received'  (duration: 456.648517ms)","trace[1194074585] 'applied index is now lower than readState.Index'  (duration: 206.122µs)"],"step_count":2}
{"level":"info","ts":"2026-02-12T02:10:47.188667Z","caller":"traceutil/trace.go:171","msg":"trace[1676898010] transaction","detail":"{read_only:false; response_revision:959; number_of_response:1; }","duration":"509.42288ms","start":"2026-02-12T02:10:46.679232Z","end":"2026-02-12T02:10:47.188655Z","steps":["trace[1676898010] 'process raft request'  (duration: 508.54658ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:10:47.189525Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:10:46.679216Z","time spent":"509.488951ms","remote":"127.0.0.1:43028","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:952 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-02-12T02:10:47.189862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"458.779652ms","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-12T02:10:47.189892Z","caller":"traceutil/trace.go:171","msg":"trace[589799008] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:959; }","duration":"458.853833ms","start":"2026-02-12T02:10:46.731031Z","end":"2026-02-12T02:10:47.189885Z","steps":["trace[589799008] 'agreement among raft nodes before linearized reading'  (duration: 458.763122ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:10:47.190067Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:10:46.73101Z","time spent":"458.898093ms","remote":"127.0.0.1:43028","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-12T02:10:47.190379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"458.871884ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-02-12T02:10:47.190407Z","caller":"traceutil/trace.go:171","msg":"trace[1433150567] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:959; }","duration":"458.924834ms","start":"2026-02-12T02:10:46.731475Z","end":"2026-02-12T02:10:47.1904Z","steps":["trace[1433150567] 'agreement among raft nodes before linearized reading'  (duration: 458.853223ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:10:47.190425Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T02:10:46.731466Z","time spent":"458.955225ms","remote":"127.0.0.1:43028","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-02-12T02:10:47.307425Z","caller":"traceutil/trace.go:171","msg":"trace[1908853846] transaction","detail":"{read_only:false; response_revision:962; number_of_response:1; }","duration":"110.10817ms","start":"2026-02-12T02:10:47.197292Z","end":"2026-02-12T02:10:47.3074Z","steps":["trace[1908853846] 'process raft request'  (duration: 110.046249ms)"],"step_count":1}
{"level":"info","ts":"2026-02-12T02:10:47.312733Z","caller":"traceutil/trace.go:171","msg":"trace[1854568520] transaction","detail":"{read_only:false; response_revision:960; number_of_response:1; }","duration":"116.875622ms","start":"2026-02-12T02:10:47.195837Z","end":"2026-02-12T02:10:47.312713Z","steps":["trace[1854568520] 'process raft request'  (duration: 18.503755ms)","trace[1854568520] 'compare'  (duration: 92.846519ms)"],"step_count":2}
{"level":"info","ts":"2026-02-12T02:10:47.313078Z","caller":"traceutil/trace.go:171","msg":"trace[1137785107] transaction","detail":"{read_only:false; response_revision:961; number_of_response:1; }","duration":"117.080694ms","start":"2026-02-12T02:10:47.195986Z","end":"2026-02-12T02:10:47.313067Z","steps":["trace[1137785107] 'process raft request'  (duration: 111.306174ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:10:51.448367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.382098ms","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-12T02:10:51.448431Z","caller":"traceutil/trace.go:171","msg":"trace[1032316603] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:976; }","duration":"105.488189ms","start":"2026-02-12T02:10:51.342928Z","end":"2026-02-12T02:10:51.448416Z","steps":["trace[1032316603] 'range keys from in-memory index tree'  (duration: 105.191606ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:10:51.448839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.814453ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-02-12T02:10:51.448948Z","caller":"traceutil/trace.go:171","msg":"trace[132159896] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:976; }","duration":"105.936074ms","start":"2026-02-12T02:10:51.342996Z","end":"2026-02-12T02:10:51.448932Z","steps":["trace[132159896] 'range keys from in-memory index tree'  (duration: 105.759693ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-12T02:10:51.449178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.502429ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-02-12T02:10:51.449231Z","caller":"traceutil/trace.go:171","msg":"trace[1601355003] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:976; }","duration":"115.582721ms","start":"2026-02-12T02:10:51.333635Z","end":"2026-02-12T02:10:51.449218Z","steps":["trace[1601355003] 'range keys from in-memory index tree'  (duration: 115.406299ms)"],"step_count":1}
{"level":"info","ts":"2026-02-12T02:10:51.573909Z","caller":"traceutil/trace.go:171","msg":"trace[367456751] transaction","detail":"{read_only:false; response_revision:978; number_of_response:1; }","duration":"114.245163ms","start":"2026-02-12T02:10:51.459626Z","end":"2026-02-12T02:10:51.573871Z","steps":["trace[367456751] 'process raft request'  (duration: 103.792238ms)","trace[367456751] 'compare'  (duration: 10.267643ms)"],"step_count":2}
{"level":"info","ts":"2026-02-12T02:10:51.574506Z","caller":"traceutil/trace.go:171","msg":"trace[94607655] transaction","detail":"{read_only:false; response_revision:979; number_of_response:1; }","duration":"114.792141ms","start":"2026-02-12T02:10:51.459693Z","end":"2026-02-12T02:10:51.574485Z","steps":["trace[94607655] 'process raft request'  (duration: 114.106682ms)"],"step_count":1}
{"level":"info","ts":"2026-02-12T02:11:24.243224Z","caller":"traceutil/trace.go:171","msg":"trace[1931198718] linearizableReadLoop","detail":"{readStateIndex:1121; appliedIndex:1120; }","duration":"106.540099ms","start":"2026-02-12T02:11:24.136653Z","end":"2026-02-12T02:11:24.243193Z","steps":["trace[1931198718] 'read index received'  (duration: 13.929005ms)","trace[1931198718] 'applied index is now lower than readState.Index'  (duration: 92.610064ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-12T02:11:24.243479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.813663ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-77cccfdc44-w4kgd\" ","response":"range_response_count:1 size:4848"}
{"level":"info","ts":"2026-02-12T02:11:24.243501Z","caller":"traceutil/trace.go:171","msg":"trace[65504571] range","detail":"{range_begin:/registry/pods/kube-system/coredns-77cccfdc44-w4kgd; range_end:; response_count:1; response_revision:1069; }","duration":"106.845183ms","start":"2026-02-12T02:11:24.136649Z","end":"2026-02-12T02:11:24.243494Z","steps":["trace[65504571] 'agreement among raft nodes before linearized reading'  (duration: 106.745121ms)"],"step_count":1}