{"level":"warn","ts":"2026-02-07T03:58:36.529309Z","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-07T03:58:36.533415Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.67: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.67:2380","--initial-cluster=instance=https://199.204.45.67:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.67:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.67: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-07T03:58:36.533485Z","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-07T03:58:36.533497Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.67:2380"]} {"level":"info","ts":"2026-02-07T03:58:36.533518Z","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-07T03:58:36.534124Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.67:2379"]} {"level":"info","ts":"2026-02-07T03:58:36.534213Z","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.67:2380"],"listen-peer-urls":["https://199.204.45.67:2380"],"advertise-client-urls":["https://199.204.45.67:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.67:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.67: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-07T03:58:36.542961Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"8.548671ms"} {"level":"info","ts":"2026-02-07T03:58:36.554066Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"cddd08233fdda28a","cluster-id":"72e3bf4964adc703"} {"level":"info","ts":"2026-02-07T03:58:36.554194Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cddd08233fdda28a switched to configuration voters=()"} {"level":"info","ts":"2026-02-07T03:58:36.554217Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cddd08233fdda28a became follower at term 0"} {"level":"info","ts":"2026-02-07T03:58:36.555043Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft cddd08233fdda28a [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-07T03:58:36.555054Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cddd08233fdda28a became follower at term 1"} {"level":"info","ts":"2026-02-07T03:58:36.555118Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cddd08233fdda28a switched to configuration voters=(14834021695116649098)"} {"level":"warn","ts":"2026-02-07T03:58:36.576885Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-07T03:58:36.609553Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-07T03:58:36.624755Z","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-07T03:58:36.627989Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"cddd08233fdda28a","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-07T03:58:36.63435Z","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-07T03:58:36.634527Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"cddd08233fdda28a","initial-advertise-peer-urls":["https://199.204.45.67:2380"],"listen-peer-urls":["https://199.204.45.67:2380"],"advertise-client-urls":["https://199.204.45.67:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.67:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-07T03:58:36.634552Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-07T03:58:36.634686Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"cddd08233fdda28a","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-07T03:58:36.63487Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.67:2380"} {"level":"info","ts":"2026-02-07T03:58:36.634884Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.67:2380"} {"level":"info","ts":"2026-02-07T03:58:36.635749Z","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-07T03:58:36.635775Z","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-07T03:58:36.635782Z","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-07T03:58:36.641583Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cddd08233fdda28a switched to configuration voters=(14834021695116649098)"} {"level":"info","ts":"2026-02-07T03:58:36.641665Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"72e3bf4964adc703","local-member-id":"cddd08233fdda28a","added-peer-id":"cddd08233fdda28a","added-peer-peer-urls":["https://199.204.45.67:2380"]} {"level":"info","ts":"2026-02-07T03:58:36.856304Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cddd08233fdda28a is starting a new election at term 1"} {"level":"info","ts":"2026-02-07T03:58:36.856342Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cddd08233fdda28a became pre-candidate at term 1"} {"level":"info","ts":"2026-02-07T03:58:36.856364Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cddd08233fdda28a received MsgPreVoteResp from cddd08233fdda28a at term 1"} {"level":"info","ts":"2026-02-07T03:58:36.856375Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cddd08233fdda28a became candidate at term 2"} {"level":"info","ts":"2026-02-07T03:58:36.856382Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cddd08233fdda28a received MsgVoteResp from cddd08233fdda28a at term 2"} {"level":"info","ts":"2026-02-07T03:58:36.85639Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cddd08233fdda28a became leader at term 2"} {"level":"info","ts":"2026-02-07T03:58:36.856401Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: cddd08233fdda28a elected leader cddd08233fdda28a at term 2"} {"level":"info","ts":"2026-02-07T03:58:36.857413Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"cddd08233fdda28a","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.67:2379]}","request-path":"/0/members/cddd08233fdda28a/attributes","cluster-id":"72e3bf4964adc703","publish-timeout":"7s"} {"level":"info","ts":"2026-02-07T03:58:36.857651Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-07T03:58:36.857756Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-07T03:58:36.858055Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-07T03:58:36.861007Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-07T03:58:36.863399Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.67:2379"} {"level":"info","ts":"2026-02-07T03:58:36.870743Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-07T03:58:36.87076Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-07T03:58:36.870782Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"72e3bf4964adc703","local-member-id":"cddd08233fdda28a","cluster-version":"3.5"} {"level":"info","ts":"2026-02-07T03:58:36.870828Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-07T03:58:36.870844Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-07T03:58:42.242368Z","caller":"traceutil/trace.go:171","msg":"trace[1986907768] transaction","detail":"{read_only:false; response_revision:266; number_of_response:1; }","duration":"175.164619ms","start":"2026-02-07T03:58:42.067188Z","end":"2026-02-07T03:58:42.242353Z","steps":["trace[1986907768] 'process raft request' (duration: 174.946815ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:58:42.742482Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11712345537753124170,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-07T03:58:43.164641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.52445ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-07T03:58:43.166209Z","caller":"traceutil/trace.go:171","msg":"trace[1272623122] transaction","detail":"{read_only:false; response_revision:267; number_of_response:1; }","duration":"1.017186471s","start":"2026-02-07T03:58:42.148807Z","end":"2026-02-07T03:58:43.165994Z","steps":["trace[1272623122] 'process raft request' (duration: 670.860227ms)","trace[1272623122] 'compare' (duration: 343.634473ms)"],"step_count":2} {"level":"warn","ts":"2026-02-07T03:58:43.16645Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T03:58:42.148798Z","time spent":"1.017611159s","remote":"127.0.0.1:47646","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":592,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-07T03:58:43.193263Z","caller":"traceutil/trace.go:171","msg":"trace[2012553321] linearizableReadLoop","detail":"{readStateIndex:280; appliedIndex:272; }","duration":"951.027586ms","start":"2026-02-07T03:58:42.242225Z","end":"2026-02-07T03:58:43.193253Z","steps":["trace[2012553321] 'read index received' (duration: 577.397408ms)","trace[2012553321] 'applied index is now lower than readState.Index' (duration: 373.629498ms)"],"step_count":2} {"level":"info","ts":"2026-02-07T03:58:43.193491Z","caller":"traceutil/trace.go:171","msg":"trace[1550528263] transaction","detail":"{read_only:false; response_revision:268; number_of_response:1; }","duration":"948.661401ms","start":"2026-02-07T03:58:42.244823Z","end":"2026-02-07T03:58:43.193485Z","steps":["trace[1550528263] 'process raft request' (duration: 948.240413ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:58:43.193563Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T03:58:42.244808Z","time spent":"948.719202ms","remote":"127.0.0.1:47898","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":373,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-07T03:58:43.193673Z","caller":"traceutil/trace.go:171","msg":"trace[1874053333] transaction","detail":"{read_only:false; number_of_response:0; response_revision:268; }","duration":"934.031115ms","start":"2026-02-07T03:58:42.259637Z","end":"2026-02-07T03:58:43.193668Z","steps":["trace[1874053333] 'process raft request' (duration: 933.478524ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:58:43.193729Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T03:58:42.259626Z","time spent":"934.090127ms","remote":"127.0.0.1:47744","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-07T03:58:43.194014Z","caller":"traceutil/trace.go:171","msg":"trace[1407673213] transaction","detail":"{read_only:false; response_revision:269; number_of_response:1; }","duration":"710.129067ms","start":"2026-02-07T03:58:42.48388Z","end":"2026-02-07T03:58:43.194009Z","steps":["trace[1407673213] 'process raft request' (duration: 709.26068ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:58:43.194158Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T03:58:42.483864Z","time spent":"710.27866ms","remote":"127.0.0.1:47746","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5855,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-07T03:58:43.194257Z","caller":"traceutil/trace.go:171","msg":"trace[790996704] transaction","detail":"{read_only:false; response_revision:270; number_of_response:1; }","duration":"710.28307ms","start":"2026-02-07T03:58:42.483968Z","end":"2026-02-07T03:58:43.194252Z","steps":["trace[790996704] 'process raft request' (duration: 709.225731ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:58:43.194331Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T03:58:42.483963Z","time spent":"710.355111ms","remote":"127.0.0.1:47746","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2883,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-07T03:58:43.194443Z","caller":"traceutil/trace.go:171","msg":"trace[183225458] transaction","detail":"{read_only:false; response_revision:271; number_of_response:1; }","duration":"710.421593ms","start":"2026-02-07T03:58:42.484016Z","end":"2026-02-07T03:58:43.194438Z","steps":["trace[183225458] 'process raft request' (duration: 709.19356ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:58:43.194487Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T03:58:42.484011Z","time spent":"710.463523ms","remote":"127.0.0.1:47746","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5476,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-07T03:58:43.194732Z","caller":"traceutil/trace.go:171","msg":"trace[269090543] transaction","detail":"{read_only:false; response_revision:272; number_of_response:1; }","duration":"710.618737ms","start":"2026-02-07T03:58:42.484107Z","end":"2026-02-07T03:58:43.194726Z","steps":["trace[269090543] 'process raft request' (duration: 709.120939ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:58:43.194802Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T03:58:42.484102Z","time spent":"710.686208ms","remote":"127.0.0.1:47746","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3937,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-07T03:58:43.194895Z","caller":"traceutil/trace.go:171","msg":"trace[1506742527] transaction","detail":"{read_only:false; number_of_response:0; response_revision:272; }","duration":"710.736539ms","start":"2026-02-07T03:58:42.484153Z","end":"2026-02-07T03:58:43.19489Z","steps":["trace[1506742527] 'process raft request' (duration: 709.086508ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:58:43.195022Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T03:58:42.484149Z","time spent":"710.835581ms","remote":"127.0.0.1:47746","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-07T03:58:43.195193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.044430745s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-node-lease/instance\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-07T03:58:43.195246Z","caller":"traceutil/trace.go:171","msg":"trace[1910099592] range","detail":"{range_begin:/registry/leases/kube-node-lease/instance; range_end:; response_count:0; response_revision:272; }","duration":"1.044490426s","start":"2026-02-07T03:58:42.150738Z","end":"2026-02-07T03:58:43.195228Z","steps":["trace[1910099592] 'agreement among raft nodes before linearized reading' (duration: 1.044372894s)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:58:43.19528Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T03:58:42.150727Z","time spent":"1.044547707s","remote":"127.0.0.1:47828","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-node-lease/instance\" "} {"level":"info","ts":"2026-02-07T03:58:43.558036Z","caller":"traceutil/trace.go:171","msg":"trace[1142784443] transaction","detail":"{read_only:false; response_revision:274; number_of_response:1; }","duration":"354.917656ms","start":"2026-02-07T03:58:43.203093Z","end":"2026-02-07T03:58:43.558011Z","steps":["trace[1142784443] 'process raft request' (duration: 354.815064ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:58:43.558157Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T03:58:43.203081Z","time spent":"355.021437ms","remote":"127.0.0.1:47914","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":400,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-07T03:58:43.558394Z","caller":"traceutil/trace.go:171","msg":"trace[838295851] transaction","detail":"{read_only:false; response_revision:273; number_of_response:1; }","duration":"387.313506ms","start":"2026-02-07T03:58:43.171068Z","end":"2026-02-07T03:58:43.558382Z","steps":["trace[838295851] 'process raft request' (duration: 384.930571ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:58:43.558461Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T03:58:43.171053Z","time spent":"387.377236ms","remote":"127.0.0.1:47646","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":625,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-07T03:58:43.5586Z","caller":"traceutil/trace.go:171","msg":"trace[1648992401] linearizableReadLoop","detail":"{readStateIndex:281; appliedIndex:280; }","duration":"365.24246ms","start":"2026-02-07T03:58:43.193348Z","end":"2026-02-07T03:58:43.558591Z","steps":["trace[1648992401] 'read index received' (duration: 362.794684ms)","trace[1648992401] 'applied index is now lower than readState.Index' (duration: 2.446656ms)"],"step_count":2} {"level":"warn","ts":"2026-02-07T03:58:43.558854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"525.417978ms","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-07T03:58:43.558894Z","caller":"traceutil/trace.go:171","msg":"trace[2033039828] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:274; }","duration":"525.52556ms","start":"2026-02-07T03:58:43.03336Z","end":"2026-02-07T03:58:43.558885Z","steps":["trace[2033039828] 'agreement among raft nodes before linearized reading' (duration: 525.402807ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:58:43.558934Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T03:58:43.033351Z","time spent":"525.577181ms","remote":"127.0.0.1:47828","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-07T03:58:43.559073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"526.399076ms","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-07T03:58:43.559106Z","caller":"traceutil/trace.go:171","msg":"trace[1014250713] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:274; }","duration":"526.467738ms","start":"2026-02-07T03:58:43.03263Z","end":"2026-02-07T03:58:43.559098Z","steps":["trace[1014250713] 'agreement among raft nodes before linearized reading' (duration: 526.415547ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:58:43.559131Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T03:58:43.032591Z","time spent":"526.534028ms","remote":"127.0.0.1:47828","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-07T03:58:43.55924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.12275085s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-07T03:58:43.559272Z","caller":"traceutil/trace.go:171","msg":"trace[202722858] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:0; response_revision:274; }","duration":"1.122816942s","start":"2026-02-07T03:58:42.436448Z","end":"2026-02-07T03:58:43.559265Z","steps":["trace[202722858] 'agreement among raft nodes before linearized reading' (duration: 1.122773961s)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:58:43.559302Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T03:58:42.436428Z","time spent":"1.122868452s","remote":"127.0.0.1:47828","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-07T03:58:43.559417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.314226877s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:1 size:664"} {"level":"info","ts":"2026-02-07T03:58:43.559447Z","caller":"traceutil/trace.go:171","msg":"trace[865321584] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:1; response_revision:274; }","duration":"1.314256518s","start":"2026-02-07T03:58:42.245183Z","end":"2026-02-07T03:58:43.55944Z","steps":["trace[865321584] 'agreement among raft nodes before linearized reading' (duration: 1.314205107s)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:58:43.559476Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T03:58:42.245157Z","time spent":"1.314314369s","remote":"127.0.0.1:47958","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":1,"response size":687,"request content":"key:\"/registry/csinodes/instance\" "} {"level":"warn","ts":"2026-02-07T03:58:43.559604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"356.458695ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3704"} {"level":"info","ts":"2026-02-07T03:58:43.559635Z","caller":"traceutil/trace.go:171","msg":"trace[283553230] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:274; }","duration":"356.503525ms","start":"2026-02-07T03:58:43.203124Z","end":"2026-02-07T03:58:43.559628Z","steps":["trace[283553230] 'agreement among raft nodes before linearized reading' (duration: 356.455434ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:58:43.559664Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T03:58:43.20312Z","time spent":"356.538726ms","remote":"127.0.0.1:47744","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3727,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-02-07T03:58:43.559902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.028379ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-07T03:58:43.559937Z","caller":"traceutil/trace.go:171","msg":"trace[81020668] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:0; response_revision:274; }","duration":"311.08679ms","start":"2026-02-07T03:58:43.248842Z","end":"2026-02-07T03:58:43.559929Z","steps":["trace[81020668] 'agreement among raft nodes before linearized reading' (duration: 311.037209ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:58:43.559963Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T03:58:43.24883Z","time spent":"311.12743ms","remote":"127.0.0.1:47828","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-07T03:58:43.560067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.0592ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-07T03:58:43.560096Z","caller":"traceutil/trace.go:171","msg":"trace[1325602521] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:274; }","duration":"354.09487ms","start":"2026-02-07T03:58:43.205994Z","end":"2026-02-07T03:58:43.560089Z","steps":["trace[1325602521] 'agreement among raft nodes before linearized reading' (duration: 354.05595ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:58:43.560135Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T03:58:43.205988Z","time spent":"354.141571ms","remote":"127.0.0.1:47588","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-07T03:58:43.560263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"357.038136ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3704"} {"level":"info","ts":"2026-02-07T03:58:43.560294Z","caller":"traceutil/trace.go:171","msg":"trace[1163507031] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:274; }","duration":"357.073566ms","start":"2026-02-07T03:58:43.203213Z","end":"2026-02-07T03:58:43.560286Z","steps":["trace[1163507031] 'agreement among raft nodes before linearized reading' (duration: 357.025395ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:58:43.560319Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T03:58:43.20321Z","time spent":"357.102997ms","remote":"127.0.0.1:47744","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3727,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-02-07T03:58:43.560434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"357.26041ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" ","response":"range_response_count:1 size:5870"} {"level":"info","ts":"2026-02-07T03:58:43.560465Z","caller":"traceutil/trace.go:171","msg":"trace[1878359345] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-instance; range_end:; response_count:1; response_revision:274; }","duration":"357.29552ms","start":"2026-02-07T03:58:43.203162Z","end":"2026-02-07T03:58:43.560457Z","steps":["trace[1878359345] 'agreement among raft nodes before linearized reading' (duration: 357.247669ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:58:43.56049Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T03:58:43.20316Z","time spent":"357.324741ms","remote":"127.0.0.1:47746","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":5893,"request content":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" "} {"level":"warn","ts":"2026-02-07T03:58:43.561533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"358.35741ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-vip-instance\" ","response":"range_response_count:1 size:3444"} {"level":"info","ts":"2026-02-07T03:58:43.561583Z","caller":"traceutil/trace.go:171","msg":"trace[1406189212] range","detail":"{range_begin:/registry/pods/kube-system/kube-vip-instance; range_end:; response_count:1; response_revision:274; }","duration":"358.425662ms","start":"2026-02-07T03:58:43.203146Z","end":"2026-02-07T03:58:43.561572Z","steps":["trace[1406189212] 'agreement among raft nodes before linearized reading' (duration: 358.332441ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:58:43.561611Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T03:58:43.203144Z","time spent":"358.461263ms","remote":"127.0.0.1:47746","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":3467,"request content":"key:\"/registry/pods/kube-system/kube-vip-instance\" "} {"level":"info","ts":"2026-02-07T03:59:10.124594Z","caller":"traceutil/trace.go:171","msg":"trace[757374538] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"776.731275ms","start":"2026-02-07T03:59:09.347847Z","end":"2026-02-07T03:59:10.124578Z","steps":["trace[757374538] 'process raft request' (duration: 776.588842ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:59:10.124895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T03:59:09.347831Z","time spent":"777.008631ms","remote":"127.0.0.1:47622","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3353,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-07T03:59:11.061492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"571.809009ms","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-07T03:59:11.061629Z","caller":"traceutil/trace.go:171","msg":"trace[528371667] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:543; }","duration":"571.941401ms","start":"2026-02-07T03:59:10.489654Z","end":"2026-02-07T03:59:11.061596Z","steps":["trace[528371667] 'range keys from in-memory index tree' (duration: 571.793559ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:59:11.061691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.282764ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-07T03:59:11.061949Z","caller":"traceutil/trace.go:171","msg":"trace[850723248] linearizableReadLoop","detail":"{readStateIndex:561; appliedIndex:558; }","duration":"1.303688186s","start":"2026-02-07T03:59:09.758243Z","end":"2026-02-07T03:59:11.061932Z","steps":["trace[850723248] 'read index received' (duration: 366.386802ms)","trace[850723248] 'applied index is now lower than readState.Index' (duration: 937.300554ms)"],"step_count":2} {"level":"info","ts":"2026-02-07T03:59:11.062016Z","caller":"traceutil/trace.go:171","msg":"trace[1811493296] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"1.481158691s","start":"2026-02-07T03:59:09.580847Z","end":"2026-02-07T03:59:11.062005Z","steps":["trace[1811493296] 'process raft request' (duration: 1.27549511s)","trace[1811493296] 'compare' (duration: 204.720553ms)"],"step_count":2} {"level":"warn","ts":"2026-02-07T03:59:11.062065Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T03:59:09.58083Z","time spent":"1.481210051s","remote":"127.0.0.1:47622","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":187455,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-07T03:59:11.062221Z","caller":"traceutil/trace.go:171","msg":"trace[255402234] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"1.313706383s","start":"2026-02-07T03:59:09.7485Z","end":"2026-02-07T03:59:11.062207Z","steps":["trace[255402234] 'process raft request' (duration: 1.313368647s)"],"step_count":1} {"level":"info","ts":"2026-02-07T03:59:11.062304Z","caller":"traceutil/trace.go:171","msg":"trace[247428933] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"1.11380385s","start":"2026-02-07T03:59:09.94849Z","end":"2026-02-07T03:59:11.062293Z","steps":["trace[247428933] 'process raft request' (duration: 1.113409753s)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:59:11.062306Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T03:59:09.748479Z","time spent":"1.313774244s","remote":"127.0.0.1:47622","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8270,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-07T03:59:11.062355Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T03:59:09.948466Z","time spent":"1.11386487s","remote":"127.0.0.1:47622","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9343,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-07T03:59:11.062514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.304263747s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-02-07T03:59:11.062541Z","caller":"traceutil/trace.go:171","msg":"trace[2033231447] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:547; }","duration":"1.304335698s","start":"2026-02-07T03:59:09.758196Z","end":"2026-02-07T03:59:11.062532Z","steps":["trace[2033231447] 'agreement among raft nodes before linearized reading' (duration: 1.304224496s)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:59:11.062567Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T03:59:09.758181Z","time spent":"1.304380519s","remote":"127.0.0.1:47828","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-02-07T03:59:11.062598Z","caller":"traceutil/trace.go:171","msg":"trace[168312772] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"1.379654775s","start":"2026-02-07T03:59:09.682932Z","end":"2026-02-07T03:59:11.062587Z","steps":["trace[168312772] 'process raft request' (duration: 1.378851641s)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:59:11.062813Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T03:59:09.682914Z","time spent":"1.379710326s","remote":"127.0.0.1:47828","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-07T03:59:11.468709Z","caller":"traceutil/trace.go:171","msg":"trace[2010284803] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"896.229067ms","start":"2026-02-07T03:59:10.572416Z","end":"2026-02-07T03:59:11.468645Z","steps":["trace[2010284803] 'process raft request' (duration: 884.861745ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:59:11.468902Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T03:59:10.572391Z","time spent":"896.450282ms","remote":"127.0.0.1:47622","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":187246,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-07T03:59:11.469147Z","caller":"traceutil/trace.go:171","msg":"trace[999136956] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"1.341293688s","start":"2026-02-07T03:59:10.127844Z","end":"2026-02-07T03:59:11.469137Z","steps":["trace[999136956] 'process raft request' (duration: 1.328660122s)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:59:11.469433Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T03:59:10.12783Z","time spent":"1.341574154s","remote":"127.0.0.1:47622","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4309,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-07T03:59:11.46963Z","caller":"traceutil/trace.go:171","msg":"trace[1140368719] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"1.320732144s","start":"2026-02-07T03:59:10.148887Z","end":"2026-02-07T03:59:11.469619Z","steps":["trace[1140368719] 'process raft request' (duration: 1.307737931s)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:59:11.469882Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T03:59:10.148874Z","time spent":"1.320968849s","remote":"127.0.0.1:47622","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":23277,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-07T03:59:11.470028Z","caller":"traceutil/trace.go:171","msg":"trace[178346153] linearizableReadLoop","detail":"{readStateIndex:565; appliedIndex:565; }","duration":"408.0247ms","start":"2026-02-07T03:59:11.061977Z","end":"2026-02-07T03:59:11.470002Z","steps":["trace[178346153] 'read index received' (duration: 394.698861ms)","trace[178346153] 'applied index is now lower than readState.Index' (duration: 13.325029ms)"],"step_count":2} {"level":"warn","ts":"2026-02-07T03:59:11.470378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"524.450035ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" ","response":"range_response_count:1 size:5177"} {"level":"info","ts":"2026-02-07T03:59:11.470429Z","caller":"traceutil/trace.go:171","msg":"trace[158706922] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io; range_end:; response_count:1; response_revision:550; }","duration":"524.532276ms","start":"2026-02-07T03:59:10.945885Z","end":"2026-02-07T03:59:11.470418Z","steps":["trace[158706922] 'agreement among raft nodes before linearized reading' (duration: 524.206409ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:59:11.470466Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T03:59:10.945872Z","time spent":"524.587677ms","remote":"127.0.0.1:47622","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":1,"response size":5200,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" "} {"level":"warn","ts":"2026-02-07T03:59:11.470823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"725.227263ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io\" ","response":"range_response_count:1 size:5586"} {"level":"info","ts":"2026-02-07T03:59:11.470893Z","caller":"traceutil/trace.go:171","msg":"trace[1118713918] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io; range_end:; response_count:1; response_revision:550; }","duration":"725.315576ms","start":"2026-02-07T03:59:10.745565Z","end":"2026-02-07T03:59:11.470881Z","steps":["trace[1118713918] 'agreement among raft nodes before linearized reading' (duration: 725.131312ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:59:11.471642Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T03:59:10.745552Z","time spent":"726.081479ms","remote":"127.0.0.1:47622","response type":"/etcdserverpb.KV/Range","request count":0,"request size":92,"response count":1,"response size":5609,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io\" "} {"level":"warn","ts":"2026-02-07T03:59:11.47326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.403694ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io\" ","response":"range_response_count:1 size:4180"} {"level":"info","ts":"2026-02-07T03:59:11.478006Z","caller":"traceutil/trace.go:171","msg":"trace[1979413707] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io; range_end:; response_count:1; response_revision:551; }","duration":"332.158943ms","start":"2026-02-07T03:59:11.145814Z","end":"2026-02-07T03:59:11.477973Z","steps":["trace[1979413707] 'agreement among raft nodes before linearized reading' (duration: 326.589079ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:59:11.480471Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T03:59:11.145796Z","time spent":"334.578818ms","remote":"127.0.0.1:47622","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":1,"response size":4203,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io\" "} {"level":"info","ts":"2026-02-07T03:59:11.473947Z","caller":"traceutil/trace.go:171","msg":"trace[1537070810] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"402.921256ms","start":"2026-02-07T03:59:11.071019Z","end":"2026-02-07T03:59:11.47394Z","steps":["trace[1537070810] 'process raft request' (duration: 401.340296ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:59:11.480774Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T03:59:11.071001Z","time spent":"409.736262ms","remote":"127.0.0.1:47828","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-07T03:59:11.476342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.57549ms","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-07T03:59:11.480987Z","caller":"traceutil/trace.go:171","msg":"trace[1993783226] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io; range_end:; response_count:1; response_revision:551; }","duration":"134.268408ms","start":"2026-02-07T03:59:11.34671Z","end":"2026-02-07T03:59:11.480978Z","steps":["trace[1993783226] 'agreement among raft nodes before linearized reading' (duration: 125.81165ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:59:11.476433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.437562286s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-02-07T03:59:11.481166Z","caller":"traceutil/trace.go:171","msg":"trace[1215015592] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:551; }","duration":"1.442331255s","start":"2026-02-07T03:59:10.038827Z","end":"2026-02-07T03:59:11.481159Z","steps":["trace[1215015592] 'agreement among raft nodes before linearized reading' (duration: 1.433715904s)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:59:11.476455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.09774274s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.67\" ","response":"range_response_count:1 size:133"} {"level":"warn","ts":"2026-02-07T03:59:11.476957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.131108723s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" ","response":"range_response_count:1 size:13229"} {"level":"warn","ts":"2026-02-07T03:59:11.476977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.266967371s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-07T03:59:11.476996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.704711445s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-02-07T03:59:11.477012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.700059308s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-02-07T03:59:11.477029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.71566746s","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-07T03:59:11.482334Z","caller":"traceutil/trace.go:171","msg":"trace[246052845] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:551; }","duration":"1.720989729s","start":"2026-02-07T03:59:09.761337Z","end":"2026-02-07T03:59:11.482327Z","steps":["trace[246052845] 'agreement among raft nodes before linearized reading' (duration: 1.711214807s)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:59:11.482559Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T03:59:09.761329Z","time spent":"1.721221893s","remote":"127.0.0.1:47828","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-07T03:59:11.482363Z","caller":"traceutil/trace.go:171","msg":"trace[772287064] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io; range_end:; response_count:1; response_revision:551; }","duration":"1.136505964s","start":"2026-02-07T03:59:10.345841Z","end":"2026-02-07T03:59:11.482347Z","steps":["trace[772287064] 'agreement among raft nodes before linearized reading' (duration: 1.126705362s)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:59:11.482741Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T03:59:10.345799Z","time spent":"1.136935432s","remote":"127.0.0.1:47622","response type":"/etcdserverpb.KV/Range","request count":0,"request size":84,"response count":1,"response size":13252,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" "} {"level":"warn","ts":"2026-02-07T03:59:11.482419Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T03:59:10.038811Z","time spent":"1.443589478s","remote":"127.0.0.1:47828","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-02-07T03:59:11.482486Z","caller":"traceutil/trace.go:171","msg":"trace[1848999899] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:551; }","duration":"1.705552201s","start":"2026-02-07T03:59:09.77693Z","end":"2026-02-07T03:59:11.482482Z","steps":["trace[1848999899] 'agreement among raft nodes before linearized reading' (duration: 1.695620856s)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:59:11.483735Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T03:59:09.776919Z","time spent":"1.706808065s","remote":"127.0.0.1:47828","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-02-07T03:59:11.482437Z","caller":"traceutil/trace.go:171","msg":"trace[1374357126] range","detail":"{range_begin:/registry/masterleases/199.204.45.67; range_end:; response_count:1; response_revision:551; }","duration":"1.103746182s","start":"2026-02-07T03:59:10.378686Z","end":"2026-02-07T03:59:11.482432Z","steps":["trace[1374357126] 'agreement among raft nodes before linearized reading' (duration: 1.093858468s)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:59:11.484095Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T03:59:10.378675Z","time spent":"1.105414743s","remote":"127.0.0.1:47612","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.204.45.67\" "} {"level":"info","ts":"2026-02-07T03:59:11.482456Z","caller":"traceutil/trace.go:171","msg":"trace[1787694430] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:551; }","duration":"1.710190807s","start":"2026-02-07T03:59:09.772261Z","end":"2026-02-07T03:59:11.482452Z","steps":["trace[1787694430] 'agreement among raft nodes before linearized reading' (duration: 1.700287883s)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:59:11.484582Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T03:59:09.772251Z","time spent":"1.712323788s","remote":"127.0.0.1:47828","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-02-07T03:59:11.482469Z","caller":"traceutil/trace.go:171","msg":"trace[1502799346] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:551; }","duration":"1.272480564s","start":"2026-02-07T03:59:10.209984Z","end":"2026-02-07T03:59:11.482465Z","steps":["trace[1502799346] 'agreement among raft nodes before linearized reading' (duration: 1.262563119s)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:59:11.484738Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T03:59:10.209972Z","time spent":"1.274759336s","remote":"127.0.0.1:47588","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-07T03:59:20.012812Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11712345537753124850,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-07T03:59:20.513853Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11712345537753124850,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-07T03:59:20.72356Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.423278059s","expected-duration":"1s"} {"level":"info","ts":"2026-02-07T03:59:20.723941Z","caller":"traceutil/trace.go:171","msg":"trace[449606773] linearizableReadLoop","detail":"{readStateIndex:606; appliedIndex:605; }","duration":"1.211952013s","start":"2026-02-07T03:59:19.511969Z","end":"2026-02-07T03:59:20.723921Z","steps":["trace[449606773] 'read index received' (duration: 1.211709868s)","trace[449606773] 'applied index is now lower than readState.Index' (duration: 241.245µs)"],"step_count":2} {"level":"info","ts":"2026-02-07T03:59:20.724205Z","caller":"traceutil/trace.go:171","msg":"trace[2146728892] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"1.424020994s","start":"2026-02-07T03:59:19.300173Z","end":"2026-02-07T03:59:20.724194Z","steps":["trace[2146728892] 'process raft request' (duration: 1.423578536s)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:59:20.72431Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T03:59:19.30016Z","time spent":"1.424071865s","remote":"127.0.0.1:47746","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16799,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-07T03:59:20.72456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.212588344s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-02-07T03:59:20.724591Z","caller":"traceutil/trace.go:171","msg":"trace[755612598] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:589; }","duration":"1.212657016s","start":"2026-02-07T03:59:19.511925Z","end":"2026-02-07T03:59:20.724582Z","steps":["trace[755612598] 'agreement among raft nodes before linearized reading' (duration: 1.212533914s)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:59:20.724618Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T03:59:19.511907Z","time spent":"1.212705537s","remote":"127.0.0.1:47828","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-07T03:59:20.724806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.154080002s","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-07T03:59:20.724835Z","caller":"traceutil/trace.go:171","msg":"trace[586699231] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:589; }","duration":"1.154128863s","start":"2026-02-07T03:59:19.570696Z","end":"2026-02-07T03:59:20.724825Z","steps":["trace[586699231] 'agreement among raft nodes before linearized reading' (duration: 1.154056942s)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:59:20.72486Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T03:59:19.570686Z","time spent":"1.154168244s","remote":"127.0.0.1:47828","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-07T03:59:20.725179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.967882ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.67\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-02-07T03:59:20.72521Z","caller":"traceutil/trace.go:171","msg":"trace[298850136] range","detail":"{range_begin:/registry/masterleases/199.204.45.67; range_end:; response_count:1; response_revision:589; }","duration":"346.036383ms","start":"2026-02-07T03:59:20.379165Z","end":"2026-02-07T03:59:20.725202Z","steps":["trace[298850136] 'agreement among raft nodes before linearized reading' (duration: 345.9437ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:59:20.725239Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T03:59:20.379143Z","time spent":"346.087864ms","remote":"127.0.0.1:47612","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.204.45.67\" "} {"level":"warn","ts":"2026-02-07T03:59:20.726102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.117352187s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-07T03:59:20.726184Z","caller":"traceutil/trace.go:171","msg":"trace[346022118] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:589; }","duration":"1.117472368s","start":"2026-02-07T03:59:19.608691Z","end":"2026-02-07T03:59:20.726164Z","steps":["trace[346022118] 'agreement among raft nodes before linearized reading' (duration: 1.117288815s)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:59:20.726227Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T03:59:19.608681Z","time spent":"1.117536679s","remote":"127.0.0.1:47828","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-07T03:59:20.726561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.152055755s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-02-07T03:59:20.7266Z","caller":"traceutil/trace.go:171","msg":"trace[1385738880] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:589; }","duration":"1.152170217s","start":"2026-02-07T03:59:19.574419Z","end":"2026-02-07T03:59:20.726589Z","steps":["trace[1385738880] 'agreement among raft nodes before linearized reading' (duration: 1.152059744s)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:59:20.726658Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T03:59:19.574408Z","time spent":"1.152240928s","remote":"127.0.0.1:47828","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-02-07T03:59:20.731013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.120391573s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-02-07T03:59:20.73105Z","caller":"traceutil/trace.go:171","msg":"trace[1044684794] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:589; }","duration":"1.120458085s","start":"2026-02-07T03:59:19.610584Z","end":"2026-02-07T03:59:20.731042Z","steps":["trace[1044684794] 'agreement among raft nodes before linearized reading' (duration: 1.114760389s)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:59:20.731075Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T03:59:19.610573Z","time spent":"1.120496676s","remote":"127.0.0.1:47828","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-02-07T03:59:29.401159Z","caller":"traceutil/trace.go:171","msg":"trace[760277762] transaction","detail":"{read_only:false; response_revision:650; number_of_response:1; }","duration":"121.963578ms","start":"2026-02-07T03:59:29.279177Z","end":"2026-02-07T03:59:29.401141Z","steps":["trace[760277762] 'process raft request' (duration: 121.842656ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:59:35.396673Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11712345537753125005,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-07T03:59:35.719488Z","caller":"traceutil/trace.go:171","msg":"trace[952596816] transaction","detail":"{read_only:false; response_revision:665; number_of_response:1; }","duration":"894.702528ms","start":"2026-02-07T03:59:34.824759Z","end":"2026-02-07T03:59:35.719462Z","steps":["trace[952596816] 'process raft request' (duration: 845.692233ms)","trace[952596816] 'compare' (duration: 48.435294ms)"],"step_count":2} {"level":"warn","ts":"2026-02-07T03:59:35.719602Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T03:59:34.824744Z","time spent":"894.79272ms","remote":"127.0.0.1:47828","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-07T03:59:35.73945Z","caller":"traceutil/trace.go:171","msg":"trace[476094251] linearizableReadLoop","detail":"{readStateIndex:687; appliedIndex:685; }","duration":"843.39341ms","start":"2026-02-07T03:59:34.896041Z","end":"2026-02-07T03:59:35.739434Z","steps":["trace[476094251] 'read index received' (duration: 774.420992ms)","trace[476094251] 'applied index is now lower than readState.Index' (duration: 68.971488ms)"],"step_count":2} {"level":"info","ts":"2026-02-07T03:59:35.739489Z","caller":"traceutil/trace.go:171","msg":"trace[1178034576] transaction","detail":"{read_only:false; response_revision:666; number_of_response:1; }","duration":"840.615778ms","start":"2026-02-07T03:59:34.898845Z","end":"2026-02-07T03:59:35.73946Z","steps":["trace[1178034576] 'process raft request' (duration: 840.505286ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:59:35.739647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"900.961745ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-02-07T03:59:35.739647Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T03:59:34.898832Z","time spent":"840.72657ms","remote":"127.0.0.1:47828","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-07T03:59:35.739685Z","caller":"traceutil/trace.go:171","msg":"trace[1233186144] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:666; }","duration":"901.017746ms","start":"2026-02-07T03:59:34.838655Z","end":"2026-02-07T03:59:35.739673Z","steps":["trace[1233186144] 'agreement among raft nodes before linearized reading' (duration: 900.869024ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:59:35.739716Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T03:59:34.838649Z","time spent":"901.059887ms","remote":"127.0.0.1:47828","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-02-07T03:59:35.74065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"537.270503ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-07T03:59:35.740716Z","caller":"traceutil/trace.go:171","msg":"trace[1370291993] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:666; }","duration":"537.365486ms","start":"2026-02-07T03:59:35.203336Z","end":"2026-02-07T03:59:35.740702Z","steps":["trace[1370291993] 'agreement among raft nodes before linearized reading' (duration: 537.272944ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:59:35.740748Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T03:59:35.203318Z","time spent":"537.423146ms","remote":"127.0.0.1:47588","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-07T03:59:35.740815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"903.679785ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-07T03:59:35.740854Z","caller":"traceutil/trace.go:171","msg":"trace[1608252852] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:666; }","duration":"903.731837ms","start":"2026-02-07T03:59:34.837112Z","end":"2026-02-07T03:59:35.740843Z","steps":["trace[1608252852] 'agreement among raft nodes before linearized reading' (duration: 903.621495ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:59:35.740883Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T03:59:34.837105Z","time spent":"903.771768ms","remote":"127.0.0.1:47828","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-07T03:59:35.740991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"917.938123ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-02-07T03:59:35.74102Z","caller":"traceutil/trace.go:171","msg":"trace[1280655049] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:666; }","duration":"917.996714ms","start":"2026-02-07T03:59:34.823014Z","end":"2026-02-07T03:59:35.741011Z","steps":["trace[1280655049] 'agreement among raft nodes before linearized reading' (duration: 917.880132ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:59:35.741046Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T03:59:34.823001Z","time spent":"918.039125ms","remote":"127.0.0.1:47828","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-02-07T03:59:36.070747Z","caller":"traceutil/trace.go:171","msg":"trace[936991356] linearizableReadLoop","detail":"{readStateIndex:690; appliedIndex:688; }","duration":"292.224247ms","start":"2026-02-07T03:59:35.778508Z","end":"2026-02-07T03:59:36.070732Z","steps":["trace[936991356] 'read index received' (duration: 38.709053ms)","trace[936991356] 'applied index is now lower than readState.Index' (duration: 253.514404ms)"],"step_count":2} {"level":"warn","ts":"2026-02-07T03:59:36.070873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.35431ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-vtrnf\" ","response":"range_response_count:1 size:18246"} {"level":"info","ts":"2026-02-07T03:59:36.070889Z","caller":"traceutil/trace.go:171","msg":"trace[1825990391] range","detail":"{range_begin:/registry/pods/kube-system/cilium-vtrnf; range_end:; response_count:1; response_revision:669; }","duration":"292.409331ms","start":"2026-02-07T03:59:35.778474Z","end":"2026-02-07T03:59:36.070884Z","steps":["trace[1825990391] 'agreement among raft nodes before linearized reading' (duration: 292.312039ms)"],"step_count":1} {"level":"info","ts":"2026-02-07T03:59:36.07103Z","caller":"traceutil/trace.go:171","msg":"trace[1374872156] transaction","detail":"{read_only:false; response_revision:669; number_of_response:1; }","duration":"319.873074ms","start":"2026-02-07T03:59:35.751129Z","end":"2026-02-07T03:59:36.071002Z","steps":["trace[1374872156] 'process raft request' (duration: 319.577449ms)"],"step_count":1} {"level":"info","ts":"2026-02-07T03:59:36.071163Z","caller":"traceutil/trace.go:171","msg":"trace[53697668] transaction","detail":"{read_only:false; response_revision:668; number_of_response:1; }","duration":"320.862192ms","start":"2026-02-07T03:59:35.750295Z","end":"2026-02-07T03:59:36.071157Z","steps":["trace[53697668] 'process raft request' (duration: 243.693401ms)","trace[53697668] 'compare' (duration: 76.634921ms)"],"step_count":2} {"level":"warn","ts":"2026-02-07T03:59:36.071193Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T03:59:35.751121Z","time spent":"319.994966ms","remote":"127.0.0.1:47828","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-07T03:59:36.071222Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T03:59:35.750287Z","time spent":"320.891862ms","remote":"127.0.0.1:47828","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-07T03:59:36.238607Z","caller":"traceutil/trace.go:171","msg":"trace[694641809] transaction","detail":"{read_only:false; response_revision:670; number_of_response:1; }","duration":"153.502437ms","start":"2026-02-07T03:59:36.085089Z","end":"2026-02-07T03:59:36.238591Z","steps":["trace[694641809] 'process raft request' (duration: 129.783174ms)","trace[694641809] 'compare' (duration: 23.635381ms)"],"step_count":2} {"level":"warn","ts":"2026-02-07T03:59:36.463985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.660239ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-02-07T03:59:36.464053Z","caller":"traceutil/trace.go:171","msg":"trace[1915298579] linearizableReadLoop","detail":"{readStateIndex:692; appliedIndex:690; }","duration":"258.300124ms","start":"2026-02-07T03:59:36.205741Z","end":"2026-02-07T03:59:36.464041Z","steps":["trace[1915298579] 'read index received' (duration: 9.117891ms)","trace[1915298579] 'applied index is now lower than readState.Index' (duration: 249.181263ms)"],"step_count":2} {"level":"warn","ts":"2026-02-07T03:59:36.464104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.355275ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-07T03:59:36.46412Z","caller":"traceutil/trace.go:171","msg":"trace[1386508224] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:670; }","duration":"258.402726ms","start":"2026-02-07T03:59:36.205711Z","end":"2026-02-07T03:59:36.464114Z","steps":["trace[1386508224] 'agreement among raft nodes before linearized reading' (duration: 258.359955ms)"],"step_count":1} {"level":"info","ts":"2026-02-07T03:59:36.535404Z","caller":"traceutil/trace.go:171","msg":"trace[2015361058] transaction","detail":"{read_only:false; response_revision:672; number_of_response:1; }","duration":"280.211203ms","start":"2026-02-07T03:59:36.255182Z","end":"2026-02-07T03:59:36.535393Z","steps":["trace[2015361058] 'process raft request' (duration: 280.180902ms)"],"step_count":1} {"level":"info","ts":"2026-02-07T03:59:36.535629Z","caller":"traceutil/trace.go:171","msg":"trace[1832459264] transaction","detail":"{read_only:false; response_revision:671; number_of_response:1; }","duration":"287.945648ms","start":"2026-02-07T03:59:36.247679Z","end":"2026-02-07T03:59:36.535624Z","steps":["trace[1832459264] 'process raft request' (duration: 287.5892ms)"],"step_count":1} {"level":"info","ts":"2026-02-07T03:59:36.873257Z","caller":"traceutil/trace.go:171","msg":"trace[1315777142] transaction","detail":"{read_only:false; response_revision:673; number_of_response:1; }","duration":"330.955091ms","start":"2026-02-07T03:59:36.542288Z","end":"2026-02-07T03:59:36.873243Z","steps":["trace[1315777142] 'process raft request' (duration: 240.929719ms)","trace[1315777142] 'compare' (duration: 89.955081ms)"],"step_count":2} {"level":"warn","ts":"2026-02-07T03:59:36.87334Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T03:59:36.542272Z","time spent":"331.023513ms","remote":"127.0.0.1:47744","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4591,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-07T03:59:36.93664Z","caller":"traceutil/trace.go:171","msg":"trace[1105956713] transaction","detail":"{read_only:false; response_revision:674; number_of_response:1; }","duration":"385.815545ms","start":"2026-02-07T03:59:36.550811Z","end":"2026-02-07T03:59:36.936626Z","steps":["trace[1105956713] 'process raft request' (duration: 385.53286ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:59:36.93673Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T03:59:36.550804Z","time spent":"385.876356ms","remote":"127.0.0.1:47746","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3798,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-07T03:59:36.936855Z","caller":"traceutil/trace.go:171","msg":"trace[1787824966] transaction","detail":"{read_only:false; response_revision:675; number_of_response:1; }","duration":"385.200513ms","start":"2026-02-07T03:59:36.551646Z","end":"2026-02-07T03:59:36.936847Z","steps":["trace[1787824966] 'process raft request' (duration: 384.773916ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:59:36.936884Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T03:59:36.55164Z","time spent":"385.227244ms","remote":"127.0.0.1:47746","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3834,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-07T03:59:36.936953Z","caller":"traceutil/trace.go:171","msg":"trace[452424499] transaction","detail":"{read_only:false; response_revision:676; number_of_response:1; }","duration":"385.213714ms","start":"2026-02-07T03:59:36.551734Z","end":"2026-02-07T03:59:36.936948Z","steps":["trace[452424499] 'process raft request' (duration: 384.715405ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:59:36.936981Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T03:59:36.55173Z","time spent":"385.235074ms","remote":"127.0.0.1:47746","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3834,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-07T03:59:38.151352Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.001972ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-07T03:59:38.151397Z","caller":"traceutil/trace.go:171","msg":"trace[1098996477] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:684; }","duration":"331.092904ms","start":"2026-02-07T03:59:37.820293Z","end":"2026-02-07T03:59:38.151386Z","steps":["trace[1098996477] 'range keys from in-memory index tree' (duration: 330.89934ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:59:38.151419Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T03:59:37.820281Z","time spent":"331.132815ms","remote":"127.0.0.1:47828","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-07T03:59:38.151582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.059984ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-07T03:59:38.151596Z","caller":"traceutil/trace.go:171","msg":"trace[2133870221] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:684; }","duration":"225.102744ms","start":"2026-02-07T03:59:37.926489Z","end":"2026-02-07T03:59:38.151591Z","steps":["trace[2133870221] 'range keys from in-memory index tree' (duration: 224.999863ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:59:38.682779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.315973ms","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-07T03:59:38.682832Z","caller":"traceutil/trace.go:171","msg":"trace[1455353944] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:691; }","duration":"131.414984ms","start":"2026-02-07T03:59:38.551404Z","end":"2026-02-07T03:59:38.682819Z","steps":["trace[1455353944] 'count revisions from in-memory index tree' (duration: 131.255662ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:59:49.027962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.712344ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-07T03:59:49.029505Z","caller":"traceutil/trace.go:171","msg":"trace[765614847] linearizableReadLoop","detail":"{readStateIndex:792; appliedIndex:790; }","duration":"292.259538ms","start":"2026-02-07T03:59:48.737234Z","end":"2026-02-07T03:59:49.029493Z","steps":["trace[765614847] 'read index received' (duration: 19.051966ms)","trace[765614847] 'applied index is now lower than readState.Index' (duration: 273.206812ms)"],"step_count":2} {"level":"info","ts":"2026-02-07T03:59:49.029671Z","caller":"traceutil/trace.go:171","msg":"trace[330270537] transaction","detail":"{read_only:false; response_revision:766; number_of_response:1; }","duration":"816.964547ms","start":"2026-02-07T03:59:48.212695Z","end":"2026-02-07T03:59:49.02966Z","steps":["trace[330270537] 'process raft request' (duration: 543.48664ms)","trace[330270537] 'compare' (duration: 271.359348ms)"],"step_count":2} {"level":"warn","ts":"2026-02-07T03:59:49.030396Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T03:59:48.212689Z","time spent":"817.67775ms","remote":"127.0.0.1:47828","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-07T03:59:49.030645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.405919ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-07T03:59:49.030674Z","caller":"traceutil/trace.go:171","msg":"trace[1300356854] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:767; }","duration":"293.464601ms","start":"2026-02-07T03:59:48.737201Z","end":"2026-02-07T03:59:49.030665Z","steps":["trace[1300356854] 'agreement among raft nodes before linearized reading' (duration: 292.562183ms)"],"step_count":1} {"level":"info","ts":"2026-02-07T03:59:49.029696Z","caller":"traceutil/trace.go:171","msg":"trace[1034053353] transaction","detail":"{read_only:false; response_revision:767; number_of_response:1; }","duration":"756.832093ms","start":"2026-02-07T03:59:48.272859Z","end":"2026-02-07T03:59:49.029691Z","steps":["trace[1034053353] 'process raft request' (duration: 756.571278ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:59:49.030848Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T03:59:48.272845Z","time spent":"757.919044ms","remote":"127.0.0.1:47828","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-07T03:59:49.641408Z","caller":"traceutil/trace.go:171","msg":"trace[1619213228] transaction","detail":"{read_only:false; response_revision:768; number_of_response:1; }","duration":"606.958893ms","start":"2026-02-07T03:59:49.034439Z","end":"2026-02-07T03:59:49.641398Z","steps":["trace[1619213228] 'process raft request' (duration: 579.973069ms)","trace[1619213228] 'compare' (duration: 26.420604ms)"],"step_count":2} {"level":"warn","ts":"2026-02-07T03:59:49.64151Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T03:59:49.034422Z","time spent":"607.028445ms","remote":"127.0.0.1:47828","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-07T03:59:49.643116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"436.892789ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-07T03:59:49.643152Z","caller":"traceutil/trace.go:171","msg":"trace[724163686] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:768; }","duration":"436.929659ms","start":"2026-02-07T03:59:49.206213Z","end":"2026-02-07T03:59:49.643143Z","steps":["trace[724163686] 'agreement among raft nodes before linearized reading' (duration: 436.873498ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:59:49.643189Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T03:59:49.20616Z","time spent":"437.025311ms","remote":"127.0.0.1:47588","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-02-07T03:59:49.641269Z","caller":"traceutil/trace.go:171","msg":"trace[300376029] linearizableReadLoop","detail":"{readStateIndex:793; appliedIndex:792; }","duration":"435.032474ms","start":"2026-02-07T03:59:49.206219Z","end":"2026-02-07T03:59:49.641252Z","steps":["trace[300376029] 'read index received' (duration: 408.193702ms)","trace[300376029] 'applied index is now lower than readState.Index' (duration: 26.838092ms)"],"step_count":2} {"level":"info","ts":"2026-02-07T03:59:50.015518Z","caller":"traceutil/trace.go:171","msg":"trace[992305654] transaction","detail":"{read_only:false; response_revision:769; number_of_response:1; }","duration":"193.080776ms","start":"2026-02-07T03:59:49.822419Z","end":"2026-02-07T03:59:50.0155Z","steps":["trace[992305654] 'process raft request' (duration: 192.982004ms)"],"step_count":1} {"level":"info","ts":"2026-02-07T03:59:57.362883Z","caller":"traceutil/trace.go:171","msg":"trace[998581442] linearizableReadLoop","detail":"{readStateIndex:822; appliedIndex:821; }","duration":"295.577892ms","start":"2026-02-07T03:59:57.067289Z","end":"2026-02-07T03:59:57.362867Z","steps":["trace[998581442] 'read index received' (duration: 295.46739ms)","trace[998581442] 'applied index is now lower than readState.Index' (duration: 109.792µs)"],"step_count":2} {"level":"info","ts":"2026-02-07T03:59:57.362973Z","caller":"traceutil/trace.go:171","msg":"trace[906116918] transaction","detail":"{read_only:false; response_revision:794; number_of_response:1; }","duration":"298.260152ms","start":"2026-02-07T03:59:57.064707Z","end":"2026-02-07T03:59:57.362967Z","steps":["trace[906116918] 'process raft request' (duration: 298.053729ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:59:57.363141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.838637ms","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-07T03:59:57.363161Z","caller":"traceutil/trace.go:171","msg":"trace[978467142] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:794; }","duration":"295.882948ms","start":"2026-02-07T03:59:57.067272Z","end":"2026-02-07T03:59:57.363155Z","steps":["trace[978467142] 'agreement among raft nodes before linearized reading' (duration: 295.789096ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:59:57.363307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.872904ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-07T03:59:57.363372Z","caller":"traceutil/trace.go:171","msg":"trace[749467561] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:794; }","duration":"156.974466ms","start":"2026-02-07T03:59:57.20638Z","end":"2026-02-07T03:59:57.363355Z","steps":["trace[749467561] 'agreement among raft nodes before linearized reading' (duration: 156.877725ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T03:59:57.689302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.832107ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-07T03:59:57.689867Z","caller":"traceutil/trace.go:171","msg":"trace[1221360927] transaction","detail":"{read_only:false; response_revision:795; number_of_response:1; }","duration":"322.40222ms","start":"2026-02-07T03:59:57.367443Z","end":"2026-02-07T03:59:57.689845Z","steps":["trace[1221360927] 'process raft request' (duration: 209.968662ms)","trace[1221360927] 'compare' (duration: 111.725476ms)"],"step_count":2} {"level":"warn","ts":"2026-02-07T03:59:57.689975Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T03:59:57.367416Z","time spent":"322.504012ms","remote":"127.0.0.1:47828","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-07T03:59:57.89704Z","caller":"traceutil/trace.go:171","msg":"trace[501638376] transaction","detail":"{read_only:false; response_revision:796; number_of_response:1; }","duration":"200.934373ms","start":"2026-02-07T03:59:57.696087Z","end":"2026-02-07T03:59:57.897021Z","steps":["trace[501638376] 'process raft request' (duration: 152.418652ms)","trace[501638376] 'compare' (duration: 48.435039ms)"],"step_count":2} {"level":"warn","ts":"2026-02-07T04:00:10.858605Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11712345537753125473,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-07T04:00:11.204188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"715.537195ms","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-07T04:00:11.204269Z","caller":"traceutil/trace.go:171","msg":"trace[1036095306] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:880; }","duration":"715.625967ms","start":"2026-02-07T04:00:10.488635Z","end":"2026-02-07T04:00:11.204261Z","steps":["trace[1036095306] 'range keys from in-memory index tree' (duration: 715.529455ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T04:00:11.205001Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.105146355s","expected-duration":"1s"} {"level":"info","ts":"2026-02-07T04:00:11.205214Z","caller":"traceutil/trace.go:171","msg":"trace[312371205] linearizableReadLoop","detail":"{readStateIndex:912; appliedIndex:911; }","duration":"846.997818ms","start":"2026-02-07T04:00:10.358209Z","end":"2026-02-07T04:00:11.205207Z","steps":["trace[312371205] 'read index received' (duration: 846.892177ms)","trace[312371205] 'applied index is now lower than readState.Index' (duration: 105.131µs)"],"step_count":2} {"level":"info","ts":"2026-02-07T04:00:11.205261Z","caller":"traceutil/trace.go:171","msg":"trace[1714929706] transaction","detail":"{read_only:false; response_revision:881; number_of_response:1; }","duration":"1.10548923s","start":"2026-02-07T04:00:10.099767Z","end":"2026-02-07T04:00:11.205256Z","steps":["trace[1714929706] 'process raft request' (duration: 1.105372798s)"],"step_count":1} {"level":"warn","ts":"2026-02-07T04:00:11.205308Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T04:00:10.09975Z","time spent":"1.105522382s","remote":"127.0.0.1:47828","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-07T04:00:11.205441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"823.184864ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.67\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-02-07T04:00:11.205468Z","caller":"traceutil/trace.go:171","msg":"trace[2137539116] range","detail":"{range_begin:/registry/masterleases/199.204.45.67; range_end:; response_count:1; response_revision:881; }","duration":"823.242897ms","start":"2026-02-07T04:00:10.382213Z","end":"2026-02-07T04:00:11.205456Z","steps":["trace[2137539116] 'agreement among raft nodes before linearized reading' (duration: 823.136255ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T04:00:11.205489Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T04:00:10.382199Z","time spent":"823.286077ms","remote":"127.0.0.1:47612","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.204.45.67\" "} {"level":"warn","ts":"2026-02-07T04:00:11.205519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"847.319335ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-07T04:00:11.205538Z","caller":"traceutil/trace.go:171","msg":"trace[656508602] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:881; }","duration":"847.340155ms","start":"2026-02-07T04:00:10.358192Z","end":"2026-02-07T04:00:11.205532Z","steps":["trace[656508602] 'agreement among raft nodes before linearized reading' (duration: 847.281203ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T04:00:11.205551Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T04:00:10.35812Z","time spent":"847.428067ms","remote":"127.0.0.1:47828","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-07T04:00:11.707494Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11712345537753125476,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-07T04:00:11.847353Z","caller":"traceutil/trace.go:171","msg":"trace[143882912] linearizableReadLoop","detail":"{readStateIndex:914; appliedIndex:912; }","duration":"640.301967ms","start":"2026-02-07T04:00:11.20703Z","end":"2026-02-07T04:00:11.847332Z","steps":["trace[143882912] 'read index received' (duration: 596.168857ms)","trace[143882912] 'applied index is now lower than readState.Index' (duration: 44.13183ms)"],"step_count":2} {"level":"warn","ts":"2026-02-07T04:00:11.847461Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T04:00:11.20649Z","time spent":"640.967801ms","remote":"127.0.0.1:47612","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-02-07T04:00:11.847754Z","caller":"traceutil/trace.go:171","msg":"trace[602179466] transaction","detail":"{read_only:false; response_revision:882; number_of_response:1; }","duration":"639.310429ms","start":"2026-02-07T04:00:11.208432Z","end":"2026-02-07T04:00:11.847742Z","steps":["trace[602179466] 'process raft request' (duration: 638.80434ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T04:00:11.847848Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T04:00:11.208425Z","time spent":"639.362969ms","remote":"127.0.0.1:47828","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-07T04:00:11.848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"640.964649ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-07T04:00:11.84803Z","caller":"traceutil/trace.go:171","msg":"trace[874232894] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:882; }","duration":"641.00698ms","start":"2026-02-07T04:00:11.207013Z","end":"2026-02-07T04:00:11.84802Z","steps":["trace[874232894] 'agreement among raft nodes before linearized reading' (duration: 640.958839ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T04:00:11.848487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"438.506078ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-02-07T04:00:11.848529Z","caller":"traceutil/trace.go:171","msg":"trace[1553896243] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:882; }","duration":"438.59698ms","start":"2026-02-07T04:00:11.409922Z","end":"2026-02-07T04:00:11.848519Z","steps":["trace[1553896243] 'agreement among raft nodes before linearized reading' (duration: 438.475187ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T04:00:11.848559Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T04:00:11.409908Z","time spent":"438.644251ms","remote":"127.0.0.1:47828","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-02-07T04:00:11.848896Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"430.660252ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-07T04:00:11.848933Z","caller":"traceutil/trace.go:171","msg":"trace[1890601998] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:882; }","duration":"430.700313ms","start":"2026-02-07T04:00:11.418224Z","end":"2026-02-07T04:00:11.848924Z","steps":["trace[1890601998] 'agreement among raft nodes before linearized reading' (duration: 430.647692ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T04:00:11.848967Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T04:00:11.41818Z","time spent":"430.779324ms","remote":"127.0.0.1:48004","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":28,"request content":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true "} {"level":"warn","ts":"2026-02-07T04:00:11.848056Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T04:00:11.207008Z","time spent":"641.04265ms","remote":"127.0.0.1:47604","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-02-07T04:00:16.193886Z","caller":"traceutil/trace.go:171","msg":"trace[545492712] transaction","detail":"{read_only:false; response_revision:894; number_of_response:1; }","duration":"328.474352ms","start":"2026-02-07T04:00:15.865387Z","end":"2026-02-07T04:00:16.193861Z","steps":["trace[545492712] 'process raft request' (duration: 328.32082ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T04:00:16.19402Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T04:00:15.865377Z","time spent":"328.575244ms","remote":"127.0.0.1:47828","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-07T04:00:16.194446Z","caller":"traceutil/trace.go:171","msg":"trace[369800093] linearizableReadLoop","detail":"{readStateIndex:927; appliedIndex:927; }","duration":"276.634001ms","start":"2026-02-07T04:00:15.917799Z","end":"2026-02-07T04:00:16.194433Z","steps":["trace[369800093] 'read index received' (duration: 276.629701ms)","trace[369800093] 'applied index is now lower than readState.Index' (duration: 3.41µs)"],"step_count":2} {"level":"warn","ts":"2026-02-07T04:00:16.194623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.816594ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-02-07T04:00:16.194656Z","caller":"traceutil/trace.go:171","msg":"trace[1824855506] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:894; }","duration":"276.849874ms","start":"2026-02-07T04:00:15.917795Z","end":"2026-02-07T04:00:16.194645Z","steps":["trace[1824855506] 'agreement among raft nodes before linearized reading' (duration: 276.699252ms)"],"step_count":1} {"level":"info","ts":"2026-02-07T04:00:16.242937Z","caller":"traceutil/trace.go:171","msg":"trace[85432073] transaction","detail":"{read_only:false; response_revision:895; number_of_response:1; }","duration":"122.606578ms","start":"2026-02-07T04:00:16.120313Z","end":"2026-02-07T04:00:16.24292Z","steps":["trace[85432073] 'process raft request' (duration: 122.494746ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T04:00:16.243408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.711556ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-02-07T04:00:16.243435Z","caller":"traceutil/trace.go:171","msg":"trace[1373572349] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:895; }","duration":"182.783287ms","start":"2026-02-07T04:00:16.060645Z","end":"2026-02-07T04:00:16.243429Z","steps":["trace[1373572349] 'agreement among raft nodes before linearized reading' (duration: 182.682405ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T04:00:16.243533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.700833ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-02-07T04:00:16.243553Z","caller":"traceutil/trace.go:171","msg":"trace[1584795544] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:895; }","duration":"325.726353ms","start":"2026-02-07T04:00:15.917821Z","end":"2026-02-07T04:00:16.243547Z","steps":["trace[1584795544] 'agreement among raft nodes before linearized reading' (duration: 325.676562ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T04:00:16.243568Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T04:00:15.917818Z","time spent":"325.744994ms","remote":"127.0.0.1:47828","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-02-07T04:00:16.367175Z","caller":"traceutil/trace.go:171","msg":"trace[766471518] transaction","detail":"{read_only:false; response_revision:897; number_of_response:1; }","duration":"120.353367ms","start":"2026-02-07T04:00:16.246806Z","end":"2026-02-07T04:00:16.367159Z","steps":["trace[766471518] 'process raft request' (duration: 105.451179ms)","trace[766471518] 'compare' (duration: 14.424169ms)"],"step_count":2} {"level":"info","ts":"2026-02-07T04:00:16.367267Z","caller":"traceutil/trace.go:171","msg":"trace[1582900483] transaction","detail":"{read_only:false; response_revision:898; number_of_response:1; }","duration":"119.339698ms","start":"2026-02-07T04:00:16.247923Z","end":"2026-02-07T04:00:16.367262Z","steps":["trace[1582900483] 'process raft request' (duration: 119.042712ms)"],"step_count":1} {"level":"info","ts":"2026-02-07T04:00:17.597013Z","caller":"traceutil/trace.go:171","msg":"trace[1808200167] transaction","detail":"{read_only:false; response_revision:899; number_of_response:1; }","duration":"374.347065ms","start":"2026-02-07T04:00:17.222642Z","end":"2026-02-07T04:00:17.596989Z","steps":["trace[1808200167] 'process raft request' (duration: 374.203822ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T04:00:17.59715Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T04:00:17.222633Z","time spent":"374.449657ms","remote":"127.0.0.1:47828","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-07T04:00:24.453464Z","caller":"traceutil/trace.go:171","msg":"trace[905154656] linearizableReadLoop","detail":"{readStateIndex:951; appliedIndex:950; }","duration":"134.56092ms","start":"2026-02-07T04:00:24.318889Z","end":"2026-02-07T04:00:24.453449Z","steps":["trace[905154656] 'read index received' (duration: 134.434468ms)","trace[905154656] 'applied index is now lower than readState.Index' (duration: 125.772µs)"],"step_count":2} {"level":"info","ts":"2026-02-07T04:00:24.453539Z","caller":"traceutil/trace.go:171","msg":"trace[1502331582] transaction","detail":"{read_only:false; response_revision:917; number_of_response:1; }","duration":"164.330063ms","start":"2026-02-07T04:00:24.289205Z","end":"2026-02-07T04:00:24.453535Z","steps":["trace[1502331582] 'process raft request' (duration: 164.1282ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T04:00:24.453697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.800285ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-02-07T04:00:24.453714Z","caller":"traceutil/trace.go:171","msg":"trace[716879475] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:917; }","duration":"134.852657ms","start":"2026-02-07T04:00:24.318856Z","end":"2026-02-07T04:00:24.453709Z","steps":["trace[716879475] 'agreement among raft nodes before linearized reading' (duration: 134.774435ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T04:00:25.161137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.988541ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-07T04:00:25.161193Z","caller":"traceutil/trace.go:171","msg":"trace[1457815571] transaction","detail":"{read_only:false; response_revision:918; number_of_response:1; }","duration":"701.371732ms","start":"2026-02-07T04:00:24.459812Z","end":"2026-02-07T04:00:25.161183Z","steps":["trace[1457815571] 'process raft request' (duration: 384.294139ms)","trace[1457815571] 'compare' (duration: 316.89241ms)"],"step_count":2} {"level":"warn","ts":"2026-02-07T04:00:25.161224Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T04:00:24.459798Z","time spent":"701.412993ms","remote":"127.0.0.1:47828","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-07T04:00:25.185662Z","caller":"traceutil/trace.go:171","msg":"trace[852224099] linearizableReadLoop","detail":"{readStateIndex:954; appliedIndex:951; }","duration":"412.858401ms","start":"2026-02-07T04:00:24.772788Z","end":"2026-02-07T04:00:25.185647Z","steps":["trace[852224099] 'read index received' (duration: 71.388486ms)","trace[852224099] 'applied index is now lower than readState.Index' (duration: 341.469335ms)"],"step_count":2} {"level":"info","ts":"2026-02-07T04:00:25.185705Z","caller":"traceutil/trace.go:171","msg":"trace[1839824722] transaction","detail":"{read_only:false; response_revision:919; number_of_response:1; }","duration":"724.457ms","start":"2026-02-07T04:00:24.461226Z","end":"2026-02-07T04:00:25.185683Z","steps":["trace[1839824722] 'process raft request' (duration: 724.301718ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T04:00:25.185771Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"412.973944ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-07T04:00:25.18579Z","caller":"traceutil/trace.go:171","msg":"trace[910817348] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:920; }","duration":"413.044625ms","start":"2026-02-07T04:00:24.77274Z","end":"2026-02-07T04:00:25.185784Z","steps":["trace[910817348] 'agreement among raft nodes before linearized reading' (duration: 412.960574ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T04:00:25.18581Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T04:00:24.772723Z","time spent":"413.081606ms","remote":"127.0.0.1:43176","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true "} {"level":"warn","ts":"2026-02-07T04:00:25.185811Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T04:00:24.461213Z","time spent":"724.540622ms","remote":"127.0.0.1:47828","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-07T04:00:25.185985Z","caller":"traceutil/trace.go:171","msg":"trace[173393305] transaction","detail":"{read_only:false; response_revision:920; number_of_response:1; }","duration":"610.936663ms","start":"2026-02-07T04:00:24.575043Z","end":"2026-02-07T04:00:25.18598Z","steps":["trace[173393305] 'process raft request' (duration: 610.570495ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T04:00:25.18603Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T04:00:24.57502Z","time spent":"610.978483ms","remote":"127.0.0.1:47828","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-07T04:00:25.764598Z","caller":"traceutil/trace.go:171","msg":"trace[2075301397] transaction","detail":"{read_only:false; response_revision:921; number_of_response:1; }","duration":"141.474759ms","start":"2026-02-07T04:00:25.623108Z","end":"2026-02-07T04:00:25.764582Z","steps":["trace[2075301397] 'process raft request' (duration: 141.359387ms)"],"step_count":1} {"level":"info","ts":"2026-02-07T04:00:27.920647Z","caller":"traceutil/trace.go:171","msg":"trace[729590305] transaction","detail":"{read_only:false; response_revision:932; number_of_response:1; }","duration":"150.062238ms","start":"2026-02-07T04:00:27.770559Z","end":"2026-02-07T04:00:27.920622Z","steps":["trace[729590305] 'process raft request' (duration: 149.938246ms)"],"step_count":1} {"level":"info","ts":"2026-02-07T04:00:28.209916Z","caller":"traceutil/trace.go:171","msg":"trace[1530339725] transaction","detail":"{read_only:false; response_revision:933; number_of_response:1; }","duration":"101.414214ms","start":"2026-02-07T04:00:28.108488Z","end":"2026-02-07T04:00:28.209902Z","steps":["trace[1530339725] 'process raft request' (duration: 77.586681ms)","trace[1530339725] 'compare' (duration: 23.408525ms)"],"step_count":2} {"level":"warn","ts":"2026-02-07T04:00:28.629347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.636806ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-07T04:00:28.62945Z","caller":"traceutil/trace.go:171","msg":"trace[1565381024] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:933; }","duration":"160.788468ms","start":"2026-02-07T04:00:28.468644Z","end":"2026-02-07T04:00:28.629432Z","steps":["trace[1565381024] 'range keys from in-memory index tree' (duration: 160.478402ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T04:00:28.907396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.549423ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-07T04:00:28.90751Z","caller":"traceutil/trace.go:171","msg":"trace[1222396340] transaction","detail":"{read_only:false; response_revision:936; number_of_response:1; }","duration":"231.477002ms","start":"2026-02-07T04:00:28.676014Z","end":"2026-02-07T04:00:28.907491Z","steps":["trace[1222396340] 'process raft request' (duration: 105.765776ms)","trace[1222396340] 'compare' (duration: 125.45068ms)"],"step_count":2} {"level":"warn","ts":"2026-02-07T04:00:29.296659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.386864ms","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-07T04:00:29.29671Z","caller":"traceutil/trace.go:171","msg":"trace[1669213782] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:936; }","duration":"116.479076ms","start":"2026-02-07T04:00:29.180218Z","end":"2026-02-07T04:00:29.296697Z","steps":["trace[1669213782] 'range keys from in-memory index tree' (duration: 116.231559ms)"],"step_count":1} {"level":"info","ts":"2026-02-07T04:00:29.485572Z","caller":"traceutil/trace.go:171","msg":"trace[132313672] transaction","detail":"{read_only:false; response_revision:937; number_of_response:1; }","duration":"181.049684ms","start":"2026-02-07T04:00:29.304506Z","end":"2026-02-07T04:00:29.485555Z","steps":["trace[132313672] 'process raft request' (duration: 180.965412ms)"],"step_count":1} {"level":"info","ts":"2026-02-07T04:00:29.486894Z","caller":"traceutil/trace.go:171","msg":"trace[1256283679] linearizableReadLoop","detail":"{readStateIndex:974; appliedIndex:972; }","duration":"177.6467ms","start":"2026-02-07T04:00:29.309238Z","end":"2026-02-07T04:00:29.486885Z","steps":["trace[1256283679] 'read index received' (duration: 177.159821ms)","trace[1256283679] 'applied index is now lower than readState.Index' (duration: 486.449µs)"],"step_count":2} {"level":"warn","ts":"2026-02-07T04:00:29.486975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.719541ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-07T04:00:29.486994Z","caller":"traceutil/trace.go:171","msg":"trace[482084902] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:939; }","duration":"177.763891ms","start":"2026-02-07T04:00:29.309225Z","end":"2026-02-07T04:00:29.486989Z","steps":["trace[482084902] 'agreement among raft nodes before linearized reading' (duration: 177.70087ms)"],"step_count":1} {"level":"info","ts":"2026-02-07T04:00:29.487151Z","caller":"traceutil/trace.go:171","msg":"trace[784610809] transaction","detail":"{read_only:false; response_revision:938; number_of_response:1; }","duration":"182.546042ms","start":"2026-02-07T04:00:29.304598Z","end":"2026-02-07T04:00:29.487144Z","steps":["trace[784610809] 'process raft request' (duration: 182.223795ms)"],"step_count":1} {"level":"info","ts":"2026-02-07T04:00:29.487284Z","caller":"traceutil/trace.go:171","msg":"trace[1570815706] transaction","detail":"{read_only:false; response_revision:939; number_of_response:1; }","duration":"181.36504ms","start":"2026-02-07T04:00:29.30585Z","end":"2026-02-07T04:00:29.487215Z","steps":["trace[1570815706] 'process raft request' (duration: 181.012353ms)"],"step_count":1} {"level":"info","ts":"2026-02-07T04:00:45.091603Z","caller":"traceutil/trace.go:171","msg":"trace[920461911] linearizableReadLoop","detail":"{readStateIndex:1079; appliedIndex:1078; }","duration":"355.262121ms","start":"2026-02-07T04:00:44.736315Z","end":"2026-02-07T04:00:45.091577Z","steps":["trace[920461911] 'read index received' (duration: 355.079617ms)","trace[920461911] 'applied index is now lower than readState.Index' (duration: 181.314µs)"],"step_count":2} {"level":"warn","ts":"2026-02-07T04:00:45.091853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.516396ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:533"} {"level":"info","ts":"2026-02-07T04:00:45.091912Z","caller":"traceutil/trace.go:171","msg":"trace[996801370] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1041; }","duration":"355.597438ms","start":"2026-02-07T04:00:44.7363Z","end":"2026-02-07T04:00:45.091897Z","steps":["trace[996801370] 'agreement among raft nodes before linearized reading' (duration: 355.386034ms)"],"step_count":1} {"level":"info","ts":"2026-02-07T04:00:45.091907Z","caller":"traceutil/trace.go:171","msg":"trace[1646601367] transaction","detail":"{read_only:false; response_revision:1041; number_of_response:1; }","duration":"376.530366ms","start":"2026-02-07T04:00:44.715344Z","end":"2026-02-07T04:00:45.091875Z","steps":["trace[1646601367] 'process raft request' (duration: 376.076107ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T04:00:45.091962Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T04:00:44.736237Z","time spent":"355.70884ms","remote":"127.0.0.1:47828","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":556,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"warn","ts":"2026-02-07T04:00:45.092041Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T04:00:44.715327Z","time spent":"376.639808ms","remote":"127.0.0.1:47828","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-07T04:00:45.708238Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11712345537753125833,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-07T04:00:46.130981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.09464ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-07T04:00:46.131374Z","caller":"traceutil/trace.go:171","msg":"trace[637868639] transaction","detail":"{read_only:false; response_revision:1042; number_of_response:1; }","duration":"1.03224484s","start":"2026-02-07T04:00:45.098828Z","end":"2026-02-07T04:00:46.131073Z","steps":["trace[637868639] 'process raft request' (duration: 720.979986ms)","trace[637868639] 'compare' (duration: 309.779336ms)"],"step_count":2} {"level":"warn","ts":"2026-02-07T04:00:46.133001Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T04:00:45.098806Z","time spent":"1.034125825s","remote":"127.0.0.1:47828","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":518,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-07T04:00:46.132618Z","caller":"traceutil/trace.go:171","msg":"trace[1544504962] transaction","detail":"{read_only:false; response_revision:1043; number_of_response:1; }","duration":"561.123506ms","start":"2026-02-07T04:00:45.571486Z","end":"2026-02-07T04:00:46.132609Z","steps":["trace[1544504962] 'process raft request' (duration: 561.042785ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T04:00:46.133483Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T04:00:45.571475Z","time spent":"561.981673ms","remote":"127.0.0.1:47744","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5897,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-07T04:00:46.136723Z","caller":"traceutil/trace.go:171","msg":"trace[1691343613] linearizableReadLoop","detail":"{readStateIndex:1081; appliedIndex:1079; }","duration":"929.180885ms","start":"2026-02-07T04:00:45.207532Z","end":"2026-02-07T04:00:46.136713Z","steps":["trace[1691343613] 'read index received' (duration: 612.288537ms)","trace[1691343613] 'applied index is now lower than readState.Index' (duration: 316.891448ms)"],"step_count":2} {"level":"warn","ts":"2026-02-07T04:00:46.136826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"929.288987ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-07T04:00:46.136846Z","caller":"traceutil/trace.go:171","msg":"trace[216298346] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1043; }","duration":"929.314728ms","start":"2026-02-07T04:00:45.207525Z","end":"2026-02-07T04:00:46.136839Z","steps":["trace[216298346] 'agreement among raft nodes before linearized reading' (duration: 929.270147ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T04:00:46.136866Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T04:00:45.207465Z","time spent":"929.396239ms","remote":"127.0.0.1:47588","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-07T04:00:46.137033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"761.323657ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-07T04:00:46.137053Z","caller":"traceutil/trace.go:171","msg":"trace[1637566140] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:1043; }","duration":"761.377907ms","start":"2026-02-07T04:00:45.375668Z","end":"2026-02-07T04:00:46.137046Z","steps":["trace[1637566140] 'agreement among raft nodes before linearized reading' (duration: 761.340457ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T04:00:46.13707Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T04:00:45.375646Z","time spent":"761.419309ms","remote":"127.0.0.1:47996","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":8,"response size":30,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "} {"level":"warn","ts":"2026-02-07T04:00:46.137254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.882336ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-02-07T04:00:46.137273Z","caller":"traceutil/trace.go:171","msg":"trace[165719858] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1043; }","duration":"148.945057ms","start":"2026-02-07T04:00:45.988322Z","end":"2026-02-07T04:00:46.137268Z","steps":["trace[165719858] 'agreement among raft nodes before linearized reading' (duration: 148.862916ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T04:00:46.138014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.868946ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-07T04:00:46.138581Z","caller":"traceutil/trace.go:171","msg":"trace[160268811] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:1043; }","duration":"198.463407ms","start":"2026-02-07T04:00:45.940107Z","end":"2026-02-07T04:00:46.138571Z","steps":["trace[160268811] 'agreement among raft nodes before linearized reading' (duration: 197.248564ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T04:00:46.139661Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.980759ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-07T04:00:46.139693Z","caller":"traceutil/trace.go:171","msg":"trace[663069972] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:1043; }","duration":"275.195994ms","start":"2026-02-07T04:00:45.864488Z","end":"2026-02-07T04:00:46.139684Z","steps":["trace[663069972] 'agreement among raft nodes before linearized reading' (duration: 274.9969ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T04:00:46.140544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"576.585934ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-02-07T04:00:46.142045Z","caller":"traceutil/trace.go:171","msg":"trace[1424858144] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1043; }","duration":"577.302336ms","start":"2026-02-07T04:00:45.563927Z","end":"2026-02-07T04:00:46.141229Z","steps":["trace[1424858144] 'agreement among raft nodes before linearized reading' (duration: 575.615455ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T04:00:46.142129Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T04:00:45.563898Z","time spent":"578.220714ms","remote":"127.0.0.1:47828","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-07T04:00:46.143415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"584.741776ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-02-07T04:00:46.143449Z","caller":"traceutil/trace.go:171","msg":"trace[331217922] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1043; }","duration":"584.790107ms","start":"2026-02-07T04:00:45.55865Z","end":"2026-02-07T04:00:46.14344Z","steps":["trace[331217922] 'agreement among raft nodes before linearized reading' (duration: 583.9252ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T04:00:46.14364Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T04:00:45.558644Z","time spent":"584.98154ms","remote":"127.0.0.1:47828","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-02-07T04:00:46.14256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"589.426313ms","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-07T04:00:46.144076Z","caller":"traceutil/trace.go:171","msg":"trace[1313660247] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1043; }","duration":"591.001272ms","start":"2026-02-07T04:00:45.553063Z","end":"2026-02-07T04:00:46.144064Z","steps":["trace[1313660247] 'agreement among raft nodes before linearized reading' (duration: 589.416903ms)"],"step_count":1} {"level":"warn","ts":"2026-02-07T04:00:46.144162Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-07T04:00:45.553043Z","time spent":"591.108213ms","remote":"127.0.0.1:47828","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\" "}