{"level":"warn","ts":"2026-02-19T02:10:03.529975Z","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-19T02:10:03.530113Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.52: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://162.253.55.52:2380","--initial-cluster=instance=https://162.253.55.52:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.52:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.52: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-19T02:10:03.530274Z","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-19T02:10:03.530296Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.52:2380"]} {"level":"info","ts":"2026-02-19T02:10:03.530337Z","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-19T02:10:03.531256Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.52:2379"]} {"level":"info","ts":"2026-02-19T02:10:03.531383Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.52:2380"],"listen-peer-urls":["https://162.253.55.52:2380"],"advertise-client-urls":["https://162.253.55.52:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.52:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.52: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-19T02:10:03.535157Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.496794ms"} {"level":"info","ts":"2026-02-19T02:10:03.541434Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"b11e7fc5714be64b","cluster-id":"9349e4f32a52a90a"} {"level":"info","ts":"2026-02-19T02:10:03.541542Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b switched to configuration voters=()"} {"level":"info","ts":"2026-02-19T02:10:03.541571Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b became follower at term 0"} {"level":"info","ts":"2026-02-19T02:10:03.541584Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft b11e7fc5714be64b [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-19T02:10:03.541595Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b became follower at term 1"} {"level":"info","ts":"2026-02-19T02:10:03.541644Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b switched to configuration voters=(12762778880000648779)"} {"level":"warn","ts":"2026-02-19T02:10:03.552086Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-19T02:10:03.556744Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-19T02:10:03.559462Z","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-19T02:10:03.56167Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"b11e7fc5714be64b","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-19T02:10:03.561956Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"b11e7fc5714be64b","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-19T02:10:03.562207Z","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-19T02:10:03.562339Z","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-19T02:10:03.562352Z","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-19T02:10:03.563289Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b switched to configuration voters=(12762778880000648779)"} {"level":"info","ts":"2026-02-19T02:10:03.563451Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"9349e4f32a52a90a","local-member-id":"b11e7fc5714be64b","added-peer-id":"b11e7fc5714be64b","added-peer-peer-urls":["https://162.253.55.52:2380"]} {"level":"info","ts":"2026-02-19T02:10:03.569585Z","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-19T02:10:03.569819Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"b11e7fc5714be64b","initial-advertise-peer-urls":["https://162.253.55.52:2380"],"listen-peer-urls":["https://162.253.55.52:2380"],"advertise-client-urls":["https://162.253.55.52:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.52:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-19T02:10:03.569849Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-19T02:10:03.569921Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.52:2380"} {"level":"info","ts":"2026-02-19T02:10:03.569932Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.52:2380"} {"level":"info","ts":"2026-02-19T02:10:03.842418Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b is starting a new election at term 1"} {"level":"info","ts":"2026-02-19T02:10:03.842472Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b became pre-candidate at term 1"} {"level":"info","ts":"2026-02-19T02:10:03.842529Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b received MsgPreVoteResp from b11e7fc5714be64b at term 1"} {"level":"info","ts":"2026-02-19T02:10:03.842541Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b became candidate at term 2"} {"level":"info","ts":"2026-02-19T02:10:03.842546Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b received MsgVoteResp from b11e7fc5714be64b at term 2"} {"level":"info","ts":"2026-02-19T02:10:03.842555Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b became leader at term 2"} {"level":"info","ts":"2026-02-19T02:10:03.842562Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: b11e7fc5714be64b elected leader b11e7fc5714be64b at term 2"} {"level":"info","ts":"2026-02-19T02:10:03.844005Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-19T02:10:03.844933Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-19T02:10:03.844927Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"b11e7fc5714be64b","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.52:2379]}","request-path":"/0/members/b11e7fc5714be64b/attributes","cluster-id":"9349e4f32a52a90a","publish-timeout":"7s"} {"level":"info","ts":"2026-02-19T02:10:03.844986Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-19T02:10:03.845478Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"9349e4f32a52a90a","local-member-id":"b11e7fc5714be64b","cluster-version":"3.5"} {"level":"info","ts":"2026-02-19T02:10:03.845707Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-19T02:10:03.845742Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-19T02:10:03.845882Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-19T02:10:03.84602Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-19T02:10:03.848131Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-19T02:10:03.850435Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.52:2379"} {"level":"warn","ts":"2026-02-19T02:10:10.017371Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.343431066s","expected-duration":"1s"} {"level":"warn","ts":"2026-02-19T02:10:10.147185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.638880226s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-19T02:10:10.147324Z","caller":"traceutil/trace.go:171","msg":"trace[1446515533] transaction","detail":"{read_only:false; response_revision:231; number_of_response:1; }","duration":"1.798613952s","start":"2026-02-19T02:10:08.348685Z","end":"2026-02-19T02:10:10.147299Z","steps":["trace[1446515533] 'process raft request' (duration: 158.128225ms)","trace[1446515533] 'compare' (duration: 1.638403263s)"],"step_count":2} {"level":"warn","ts":"2026-02-19T02:10:10.147422Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:10:08.348658Z","time spent":"1.798724453s","remote":"127.0.0.1:34522","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3692,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-19T02:10:10.147535Z","caller":"traceutil/trace.go:171","msg":"trace[113054754] linearizableReadLoop","detail":"{readStateIndex:237; appliedIndex:236; }","duration":"1.78610848s","start":"2026-02-19T02:10:08.361405Z","end":"2026-02-19T02:10:10.147513Z","steps":["trace[113054754] 'read index received' (duration: 145.347912ms)","trace[113054754] 'applied index is now lower than readState.Index' (duration: 1.640637397s)"],"step_count":2} {"level":"warn","ts":"2026-02-19T02:10:10.147565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.78611146s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replication-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-19T02:10:10.147625Z","caller":"traceutil/trace.go:171","msg":"trace[633035211] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replication-controller; range_end:; response_count:0; response_revision:232; }","duration":"1.786235311s","start":"2026-02-19T02:10:08.36138Z","end":"2026-02-19T02:10:10.147616Z","steps":["trace[633035211] 'agreement among raft nodes before linearized reading' (duration: 1.78609488s)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:10:10.147647Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:10:08.361372Z","time spent":"1.786268941s","remote":"127.0.0.1:34556","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":0,"response size":29,"request content":"key:\"/registry/serviceaccounts/kube-system/replication-controller\" "} {"level":"warn","ts":"2026-02-19T02:10:10.147747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"639.840135ms","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-19T02:10:10.147779Z","caller":"traceutil/trace.go:171","msg":"trace[9464678] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:232; }","duration":"639.903405ms","start":"2026-02-19T02:10:09.507868Z","end":"2026-02-19T02:10:10.147771Z","steps":["trace[9464678] 'agreement among raft nodes before linearized reading' (duration: 639.763234ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:10:10.1478Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:10:09.507852Z","time spent":"639.943025ms","remote":"127.0.0.1:34632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-19T02:10:10.14783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"640.222977ms","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-19T02:10:10.147901Z","caller":"traceutil/trace.go:171","msg":"trace[477993562] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:232; }","duration":"640.349097ms","start":"2026-02-19T02:10:09.507534Z","end":"2026-02-19T02:10:10.147884Z","steps":["trace[477993562] 'agreement among raft nodes before linearized reading' (duration: 640.163836ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:10:10.147914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"643.629549ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-19T02:10:10.147934Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:10:09.507514Z","time spent":"640.412948ms","remote":"127.0.0.1:34632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-02-19T02:10:10.147949Z","caller":"traceutil/trace.go:171","msg":"trace[1033557803] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:0; response_revision:232; }","duration":"643.698599ms","start":"2026-02-19T02:10:09.504243Z","end":"2026-02-19T02:10:10.147942Z","steps":["trace[1033557803] 'agreement among raft nodes before linearized reading' (duration: 643.352607ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:10:10.147969Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:10:09.504224Z","time spent":"643.740569ms","remote":"127.0.0.1:34632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":29,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-02-19T02:10:10.147452Z","caller":"traceutil/trace.go:171","msg":"trace[944141009] transaction","detail":"{read_only:false; response_revision:232; number_of_response:1; }","duration":"1.473619344s","start":"2026-02-19T02:10:08.673823Z","end":"2026-02-19T02:10:10.147442Z","steps":["trace[944141009] 'process raft request' (duration: 1.473445622s)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:10:10.14814Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:10:08.673796Z","time spent":"1.474298808s","remote":"127.0.0.1:34534","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2883,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-19T02:10:10.148056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"414.384411ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-02-19T02:10:10.148382Z","caller":"traceutil/trace.go:171","msg":"trace[1418075504] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:232; }","duration":"415.027714ms","start":"2026-02-19T02:10:09.733334Z","end":"2026-02-19T02:10:10.148362Z","steps":["trace[1418075504] 'agreement among raft nodes before linearized reading' (duration: 414.27715ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:10:10.148704Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:10:09.733312Z","time spent":"415.376037ms","remote":"127.0.0.1:34632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-19T02:10:10.65214Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16594529272552920888,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-19T02:10:11.155587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"436.49329ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-19T02:10:11.155707Z","caller":"traceutil/trace.go:171","msg":"trace[814968593] transaction","detail":"{read_only:false; response_revision:233; number_of_response:1; }","duration":"1.004839697s","start":"2026-02-19T02:10:10.150849Z","end":"2026-02-19T02:10:11.155688Z","steps":["trace[814968593] 'process raft request' (duration: 568.163326ms)","trace[814968593] 'compare' (duration: 436.374259ms)"],"step_count":2} {"level":"warn","ts":"2026-02-19T02:10:11.15577Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:10:10.150833Z","time spent":"1.004908417s","remote":"127.0.0.1:34632","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-19T02:10:11.156262Z","caller":"traceutil/trace.go:171","msg":"trace[1137036588] transaction","detail":"{read_only:false; response_revision:234; number_of_response:1; }","duration":"1.004970288s","start":"2026-02-19T02:10:10.151262Z","end":"2026-02-19T02:10:11.156232Z","steps":["trace[1137036588] 'process raft request' (duration: 1.004784577s)"],"step_count":1} {"level":"info","ts":"2026-02-19T02:10:11.156322Z","caller":"traceutil/trace.go:171","msg":"trace[503854338] transaction","detail":"{read_only:false; response_revision:235; number_of_response:1; }","duration":"1.005041319s","start":"2026-02-19T02:10:10.151262Z","end":"2026-02-19T02:10:11.156303Z","steps":["trace[503854338] 'process raft request' (duration: 1.004909988s)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:10:11.156393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:10:10.151242Z","time spent":"1.005114449s","remote":"127.0.0.1:34632","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-19T02:10:11.156407Z","caller":"traceutil/trace.go:171","msg":"trace[1225865765] transaction","detail":"{read_only:false; response_revision:236; number_of_response:1; }","duration":"1.004531876s","start":"2026-02-19T02:10:10.151831Z","end":"2026-02-19T02:10:11.156362Z","steps":["trace[1225865765] 'process raft request' (duration: 1.004397025s)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:10:11.156443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.005241449s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/bootstrap-token-cya8a0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-19T02:10:11.156507Z","caller":"traceutil/trace.go:171","msg":"trace[1129600924] range","detail":"{range_begin:/registry/secrets/kube-system/bootstrap-token-cya8a0; range_end:; response_count:0; response_revision:236; }","duration":"1.005337511s","start":"2026-02-19T02:10:10.151155Z","end":"2026-02-19T02:10:11.156493Z","steps":["trace[1129600924] 'agreement among raft nodes before linearized reading' (duration: 1.00518248s)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:10:11.156587Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:10:10.151821Z","time spent":"1.004674617s","remote":"127.0.0.1:34632","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-19T02:10:11.156606Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:10:10.151144Z","time spent":"1.005404211s","remote":"127.0.0.1:34424","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":0,"response size":29,"request content":"key:\"/registry/secrets/kube-system/bootstrap-token-cya8a0\" "} {"level":"info","ts":"2026-02-19T02:10:11.156301Z","caller":"traceutil/trace.go:171","msg":"trace[1168470994] linearizableReadLoop","detail":"{readStateIndex:242; appliedIndex:238; }","duration":"1.005094889s","start":"2026-02-19T02:10:10.151186Z","end":"2026-02-19T02:10:11.15628Z","steps":["trace[1168470994] 'read index received' (duration: 567.968064ms)","trace[1168470994] 'applied index is now lower than readState.Index' (duration: 437.125655ms)"],"step_count":2} {"level":"warn","ts":"2026-02-19T02:10:11.156815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.005577702s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-02-19T02:10:11.156852Z","caller":"traceutil/trace.go:171","msg":"trace[375747287] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:236; }","duration":"1.005645612s","start":"2026-02-19T02:10:10.151195Z","end":"2026-02-19T02:10:11.156841Z","steps":["trace[375747287] 'agreement among raft nodes before linearized reading' (duration: 1.005574762s)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:10:11.156881Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:10:10.151181Z","time spent":"1.005694522s","remote":"127.0.0.1:34450","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":375,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-02-19T02:10:11.156471Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:10:10.151242Z","time spent":"1.005106159s","remote":"127.0.0.1:34632","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-19T02:10:35.847847Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16594529272552921356,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-19T02:10:35.905689Z","caller":"traceutil/trace.go:171","msg":"trace[288930577] linearizableReadLoop","detail":"{readStateIndex:487; appliedIndex:486; }","duration":"558.250509ms","start":"2026-02-19T02:10:35.347415Z","end":"2026-02-19T02:10:35.905666Z","steps":["trace[288930577] 'read index received' (duration: 558.055458ms)","trace[288930577] 'applied index is now lower than readState.Index' (duration: 193.971µs)"],"step_count":2} {"level":"info","ts":"2026-02-19T02:10:35.905809Z","caller":"traceutil/trace.go:171","msg":"trace[304535048] transaction","detail":"{read_only:false; response_revision:469; number_of_response:1; }","duration":"847.076427ms","start":"2026-02-19T02:10:35.05872Z","end":"2026-02-19T02:10:35.905796Z","steps":["trace[304535048] 'process raft request' (duration: 846.754235ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:10:35.905909Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:10:35.0587Z","time spent":"847.137037ms","remote":"127.0.0.1:34522","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4212,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-19T02:10:35.906125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"550.101424ms","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-19T02:10:35.906167Z","caller":"traceutil/trace.go:171","msg":"trace[870776597] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:469; }","duration":"550.177715ms","start":"2026-02-19T02:10:35.355976Z","end":"2026-02-19T02:10:35.906154Z","steps":["trace[870776597] 'agreement among raft nodes before linearized reading' (duration: 550.100474ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:10:35.906156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"554.509848ms","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-19T02:10:35.906211Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:10:35.355955Z","time spent":"550.247996ms","remote":"127.0.0.1:34632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-02-19T02:10:35.906229Z","caller":"traceutil/trace.go:171","msg":"trace[487508865] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:469; }","duration":"554.614589ms","start":"2026-02-19T02:10:35.351593Z","end":"2026-02-19T02:10:35.906208Z","steps":["trace[487508865] 'agreement among raft nodes before linearized reading' (duration: 554.469548ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:10:35.906273Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:10:35.351583Z","time spent":"554.680709ms","remote":"127.0.0.1:34632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-19T02:10:35.906497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"550.570137ms","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-19T02:10:35.906538Z","caller":"traceutil/trace.go:171","msg":"trace[1980844513] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:469; }","duration":"550.633877ms","start":"2026-02-19T02:10:35.355895Z","end":"2026-02-19T02:10:35.906529Z","steps":["trace[1980844513] 'agreement among raft nodes before linearized reading' (duration: 550.568957ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:10:35.906565Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:10:35.355878Z","time spent":"550.680918ms","remote":"127.0.0.1:34632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-19T02:10:35.906844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"558.764992ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-02-19T02:10:35.906891Z","caller":"traceutil/trace.go:171","msg":"trace[1162962575] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:469; }","duration":"559.520896ms","start":"2026-02-19T02:10:35.347358Z","end":"2026-02-19T02:10:35.906879Z","steps":["trace[1162962575] 'agreement among raft nodes before linearized reading' (duration: 558.702892ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:10:35.906921Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:10:35.347333Z","time spent":"559.579886ms","remote":"127.0.0.1:34632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-19T02:10:36.093892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.355019ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-19T02:10:36.094034Z","caller":"traceutil/trace.go:171","msg":"trace[2006975019] transaction","detail":"{read_only:false; response_revision:470; number_of_response:1; }","duration":"183.191805ms","start":"2026-02-19T02:10:35.910823Z","end":"2026-02-19T02:10:36.094015Z","steps":["trace[2006975019] 'process raft request' (duration: 31.633585ms)","trace[2006975019] 'compare' (duration: 151.248289ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T02:10:36.102173Z","caller":"traceutil/trace.go:171","msg":"trace[832140254] transaction","detail":"{read_only:false; response_revision:473; number_of_response:1; }","duration":"190.540715ms","start":"2026-02-19T02:10:35.911607Z","end":"2026-02-19T02:10:36.102147Z","steps":["trace[832140254] 'process raft request' (duration: 190.502125ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T02:10:36.102266Z","caller":"traceutil/trace.go:171","msg":"trace[1011060276] transaction","detail":"{read_only:false; response_revision:471; number_of_response:1; }","duration":"191.34232ms","start":"2026-02-19T02:10:35.910888Z","end":"2026-02-19T02:10:36.10223Z","steps":["trace[1011060276] 'process raft request' (duration: 191.086638ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T02:10:36.102275Z","caller":"traceutil/trace.go:171","msg":"trace[1226138783] transaction","detail":"{read_only:false; response_revision:472; number_of_response:1; }","duration":"191.35259ms","start":"2026-02-19T02:10:35.910888Z","end":"2026-02-19T02:10:36.102241Z","steps":["trace[1226138783] 'process raft request' (duration: 191.191249ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:10:42.34087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.684492ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-02-19T02:10:42.341016Z","caller":"traceutil/trace.go:171","msg":"trace[2038927177] linearizableReadLoop","detail":"{readStateIndex:528; appliedIndex:527; }","duration":"224.444268ms","start":"2026-02-19T02:10:42.116545Z","end":"2026-02-19T02:10:42.340989Z","steps":["trace[2038927177] 'read index received' (duration: 40.569316ms)","trace[2038927177] 'applied index is now lower than readState.Index' (duration: 183.873232ms)"],"step_count":2} {"level":"warn","ts":"2026-02-19T02:10:42.341197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.87108ms","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-19T02:10:42.341219Z","caller":"traceutil/trace.go:171","msg":"trace[489601728] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:508; }","duration":"220.909871ms","start":"2026-02-19T02:10:42.120303Z","end":"2026-02-19T02:10:42.341213Z","steps":["trace[489601728] 'agreement among raft nodes before linearized reading' (duration: 220.80122ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:10:42.341175Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.60135ms","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-19T02:10:42.341275Z","caller":"traceutil/trace.go:171","msg":"trace[1751523611] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:508; }","duration":"224.750371ms","start":"2026-02-19T02:10:42.116499Z","end":"2026-02-19T02:10:42.34125Z","steps":["trace[1751523611] 'agreement among raft nodes before linearized reading' (duration: 224.56817ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:10:42.341393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.259406ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-02-19T02:10:42.341405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.611768ms","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-19T02:10:42.341464Z","caller":"traceutil/trace.go:171","msg":"trace[1017477505] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:508; }","duration":"205.688249ms","start":"2026-02-19T02:10:42.135756Z","end":"2026-02-19T02:10:42.341445Z","steps":["trace[1017477505] 'agreement among raft nodes before linearized reading' (duration: 205.586428ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:10:42.341446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.173103ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-19T02:10:42.34153Z","caller":"traceutil/trace.go:171","msg":"trace[1899021652] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:508; }","duration":"205.335647ms","start":"2026-02-19T02:10:42.136098Z","end":"2026-02-19T02:10:42.341434Z","steps":["trace[1899021652] 'agreement among raft nodes before linearized reading' (duration: 205.217496ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T02:10:42.341554Z","caller":"traceutil/trace.go:171","msg":"trace[621755450] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:508; }","duration":"152.349843ms","start":"2026-02-19T02:10:42.189174Z","end":"2026-02-19T02:10:42.341524Z","steps":["trace[621755450] 'agreement among raft nodes before linearized reading' (duration: 152.090092ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T02:10:42.832822Z","caller":"traceutil/trace.go:171","msg":"trace[1993923826] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"485.965796ms","start":"2026-02-19T02:10:42.346816Z","end":"2026-02-19T02:10:42.832782Z","steps":["trace[1993923826] 'process raft request' (duration: 474.213163ms)","trace[1993923826] 'compare' (duration: 11.497631ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T02:10:42.832902Z","caller":"traceutil/trace.go:171","msg":"trace[184481196] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"485.654094ms","start":"2026-02-19T02:10:42.347226Z","end":"2026-02-19T02:10:42.83288Z","steps":["trace[184481196] 'process raft request' (duration: 485.606664ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:10:42.832973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:10:42.346803Z","time spent":"486.091536ms","remote":"127.0.0.1:34632","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-19T02:10:42.833036Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:10:42.34721Z","time spent":"485.753584ms","remote":"127.0.0.1:34632","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-19T02:10:42.833122Z","caller":"traceutil/trace.go:171","msg":"trace[51842681] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"486.241577ms","start":"2026-02-19T02:10:42.346846Z","end":"2026-02-19T02:10:42.833088Z","steps":["trace[51842681] 'process raft request' (duration: 485.882325ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:10:42.833317Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:10:42.346803Z","time spent":"486.423909ms","remote":"127.0.0.1:34632","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-19T02:10:42.90762Z","caller":"traceutil/trace.go:171","msg":"trace[1994089722] linearizableReadLoop","detail":"{readStateIndex:533; appliedIndex:529; }","duration":"154.652146ms","start":"2026-02-19T02:10:42.752951Z","end":"2026-02-19T02:10:42.907603Z","steps":["trace[1994089722] 'read index received' (duration: 68.081813ms)","trace[1994089722] 'applied index is now lower than readState.Index' (duration: 86.569463ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T02:10:42.907768Z","caller":"traceutil/trace.go:171","msg":"trace[701844000] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"217.835444ms","start":"2026-02-19T02:10:42.689877Z","end":"2026-02-19T02:10:42.907713Z","steps":["trace[701844000] 'process raft request' (duration: 217.605793ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:10:42.907879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.924887ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-h6hjp\" ","response":"range_response_count:1 size:16652"} {"level":"info","ts":"2026-02-19T02:10:42.907929Z","caller":"traceutil/trace.go:171","msg":"trace[1458388950] range","detail":"{range_begin:/registry/pods/kube-system/cilium-h6hjp; range_end:; response_count:1; response_revision:513; }","duration":"155.009228ms","start":"2026-02-19T02:10:42.752908Z","end":"2026-02-19T02:10:42.907917Z","steps":["trace[1458388950] 'agreement among raft nodes before linearized reading' (duration: 154.760247ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T02:10:43.219115Z","caller":"traceutil/trace.go:171","msg":"trace[1650311315] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"293.777583ms","start":"2026-02-19T02:10:42.925289Z","end":"2026-02-19T02:10:43.219067Z","steps":["trace[1650311315] 'process raft request' (duration: 293.113476ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:10:45.035539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"678.429212ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-02-19T02:10:45.035576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.97351ms","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-19T02:10:45.035632Z","caller":"traceutil/trace.go:171","msg":"trace[2057230227] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:514; }","duration":"678.57606ms","start":"2026-02-19T02:10:44.357033Z","end":"2026-02-19T02:10:45.035609Z","steps":["trace[2057230227] 'range keys from in-memory index tree' (duration: 678.318585ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T02:10:45.035646Z","caller":"traceutil/trace.go:171","msg":"trace[347167385] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:514; }","duration":"198.083626ms","start":"2026-02-19T02:10:44.837542Z","end":"2026-02-19T02:10:45.035626Z","steps":["trace[347167385] 'range keys from in-memory index tree' (duration: 197.899646ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:10:45.035683Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:10:44.357012Z","time spent":"678.662315ms","remote":"127.0.0.1:34632","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-19T02:10:45.035718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.177212ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-02-19T02:10:45.035858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.971721ms","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-19T02:10:45.035865Z","caller":"traceutil/trace.go:171","msg":"trace[572133793] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:514; }","duration":"198.417356ms","start":"2026-02-19T02:10:44.837413Z","end":"2026-02-19T02:10:45.03583Z","steps":["trace[572133793] 'range keys from in-memory index tree' (duration: 198.013893ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T02:10:45.036005Z","caller":"traceutil/trace.go:171","msg":"trace[1228138926] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:514; }","duration":"198.128139ms","start":"2026-02-19T02:10:44.83786Z","end":"2026-02-19T02:10:45.035988Z","steps":["trace[1228138926] 'range keys from in-memory index tree' (duration: 197.325535ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T02:10:47.463928Z","caller":"traceutil/trace.go:171","msg":"trace[854310753] linearizableReadLoop","detail":"{readStateIndex:561; appliedIndex:560; }","duration":"372.298038ms","start":"2026-02-19T02:10:47.091582Z","end":"2026-02-19T02:10:47.46388Z","steps":["trace[854310753] 'read index received' (duration: 371.78988ms)","trace[854310753] 'applied index is now lower than readState.Index' (duration: 506.478µs)"],"step_count":2} {"level":"info","ts":"2026-02-19T02:10:47.464003Z","caller":"traceutil/trace.go:171","msg":"trace[1091828184] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"438.091382ms","start":"2026-02-19T02:10:47.025878Z","end":"2026-02-19T02:10:47.463969Z","steps":["trace[1091828184] 'process raft request' (duration: 437.360131ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:10:47.464149Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:10:47.025845Z","time spent":"438.23927ms","remote":"127.0.0.1:34388","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3202,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-19T02:10:47.46418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"372.582784ms","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-19T02:10:47.464263Z","caller":"traceutil/trace.go:171","msg":"trace[771091526] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:540; }","duration":"372.715841ms","start":"2026-02-19T02:10:47.091535Z","end":"2026-02-19T02:10:47.464251Z","steps":["trace[771091526] 'agreement among raft nodes before linearized reading' (duration: 372.526201ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:10:47.464288Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:10:47.091515Z","time spent":"372.768164ms","remote":"127.0.0.1:34632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-19T02:10:47.467151Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.954047ms","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-19T02:10:47.467213Z","caller":"traceutil/trace.go:171","msg":"trace[1851318266] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:542; }","duration":"369.067503ms","start":"2026-02-19T02:10:47.098131Z","end":"2026-02-19T02:10:47.467199Z","steps":["trace[1851318266] 'agreement among raft nodes before linearized reading' (duration: 368.935866ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:10:47.467249Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:10:47.098083Z","time spent":"369.158238ms","remote":"127.0.0.1:34632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-19T02:10:47.467434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.542648ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-19T02:10:47.467463Z","caller":"traceutil/trace.go:171","msg":"trace[1983045622] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:542; }","duration":"278.622632ms","start":"2026-02-19T02:10:47.188831Z","end":"2026-02-19T02:10:47.467454Z","steps":["trace[1983045622] 'agreement among raft nodes before linearized reading' (duration: 278.58017ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T02:10:47.467562Z","caller":"traceutil/trace.go:171","msg":"trace[694476965] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"241.401879ms","start":"2026-02-19T02:10:47.226118Z","end":"2026-02-19T02:10:47.46752Z","steps":["trace[694476965] 'process raft request' (duration: 240.802707ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:10:47.467681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.169449ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-02-19T02:10:47.46772Z","caller":"traceutil/trace.go:171","msg":"trace[109204988] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:542; }","duration":"369.220942ms","start":"2026-02-19T02:10:47.098488Z","end":"2026-02-19T02:10:47.467709Z","steps":["trace[109204988] 'agreement among raft nodes before linearized reading' (duration: 369.151598ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:10:47.46775Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:10:47.09848Z","time spent":"369.263774ms","remote":"127.0.0.1:34632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-19T02:10:47.467879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.602362ms","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-19T02:10:47.467905Z","caller":"traceutil/trace.go:171","msg":"trace[1389824220] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:542; }","duration":"369.677686ms","start":"2026-02-19T02:10:47.098219Z","end":"2026-02-19T02:10:47.467897Z","steps":["trace[1389824220] 'agreement among raft nodes before linearized reading' (duration: 369.631073ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:10:47.467935Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:10:47.098165Z","time spent":"369.763521ms","remote":"127.0.0.1:34632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-02-19T02:12:21.742028Z","caller":"traceutil/trace.go:171","msg":"trace[1942789330] transaction","detail":"{read_only:false; response_revision:974; number_of_response:1; }","duration":"409.89638ms","start":"2026-02-19T02:12:21.332088Z","end":"2026-02-19T02:12:21.741984Z","steps":["trace[1942789330] 'process raft request' (duration: 409.625074ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:12:21.742222Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:12:21.33207Z","time spent":"410.053983ms","remote":"127.0.0.1:34632","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"}