{"level":"warn","ts":"2026-02-04T22:31:48.768995Z","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-04T22:31:48.769154Z","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-04T22:31:48.769253Z","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-04T22:31:48.769297Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.52:2380"]} {"level":"info","ts":"2026-02-04T22:31:48.769335Z","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-04T22:31:48.769949Z","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-04T22:31:48.770074Z","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://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-04T22:31:48.774196Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.835216ms"} {"level":"info","ts":"2026-02-04T22:31:48.792581Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"b11e7fc5714be64b","cluster-id":"9349e4f32a52a90a"} {"level":"info","ts":"2026-02-04T22:31:48.792665Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b switched to configuration voters=()"} {"level":"info","ts":"2026-02-04T22:31:48.7927Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b became follower at term 0"} {"level":"info","ts":"2026-02-04T22:31:48.792744Z","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-04T22:31:48.792767Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b became follower at term 1"} {"level":"info","ts":"2026-02-04T22:31:48.792833Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b switched to configuration voters=(12762778880000648779)"} {"level":"warn","ts":"2026-02-04T22:31:48.80363Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-04T22:31:48.806681Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-04T22:31:48.810343Z","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-04T22:31:48.815534Z","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-04T22:31:48.815884Z","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-04T22:31:48.815986Z","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-04T22:31:48.816035Z","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-04T22:31:48.816044Z","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-04T22:31:48.81655Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b switched to configuration voters=(12762778880000648779)"} {"level":"info","ts":"2026-02-04T22:31:48.816828Z","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-04T22:31:48.82366Z","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-04T22:31:48.823864Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.52:2380"} {"level":"info","ts":"2026-02-04T22:31:48.823902Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.52:2380"} {"level":"info","ts":"2026-02-04T22:31:48.824935Z","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-04T22:31:48.828359Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-04T22:31:49.094497Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b is starting a new election at term 1"} {"level":"info","ts":"2026-02-04T22:31:49.094579Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b became pre-candidate at term 1"} {"level":"info","ts":"2026-02-04T22:31:49.09466Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b received MsgPreVoteResp from b11e7fc5714be64b at term 1"} {"level":"info","ts":"2026-02-04T22:31:49.09469Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b became candidate at term 2"} {"level":"info","ts":"2026-02-04T22:31:49.094707Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b received MsgVoteResp from b11e7fc5714be64b at term 2"} {"level":"info","ts":"2026-02-04T22:31:49.094802Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b became leader at term 2"} {"level":"info","ts":"2026-02-04T22:31:49.094842Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: b11e7fc5714be64b elected leader b11e7fc5714be64b at term 2"} {"level":"info","ts":"2026-02-04T22:31:49.110603Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-04T22:31:49.114031Z","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-04T22:31:49.114164Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-04T22:31:49.11447Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-04T22:31:49.121023Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-04T22:31:49.122947Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.52:2379"} {"level":"info","ts":"2026-02-04T22:31:49.123019Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-04T22:31:49.12306Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-04T22:31:49.123044Z","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-04T22:31:49.12726Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-04T22:31:49.127303Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-04T22:32:07.68091Z","caller":"traceutil/trace.go:171","msg":"trace[192963315] transaction","detail":"{read_only:false; response_revision:449; number_of_response:1; }","duration":"271.614639ms","start":"2026-02-04T22:32:07.40927Z","end":"2026-02-04T22:32:07.680885Z","steps":["trace[192963315] 'process raft request' (duration: 271.464628ms)"],"step_count":1} {"level":"info","ts":"2026-02-04T22:32:08.310509Z","caller":"traceutil/trace.go:171","msg":"trace[41128049] linearizableReadLoop","detail":"{readStateIndex:462; appliedIndex:461; }","duration":"882.986834ms","start":"2026-02-04T22:32:07.4275Z","end":"2026-02-04T22:32:08.310487Z","steps":["trace[41128049] 'read index received' (duration: 253.881281ms)","trace[41128049] 'applied index is now lower than readState.Index' (duration: 629.104533ms)"],"step_count":2} {"level":"info","ts":"2026-02-04T22:32:08.310623Z","caller":"traceutil/trace.go:171","msg":"trace[393290632] transaction","detail":"{read_only:false; response_revision:450; number_of_response:1; }","duration":"899.978988ms","start":"2026-02-04T22:32:07.410634Z","end":"2026-02-04T22:32:08.310613Z","steps":["trace[393290632] 'process raft request' (duration: 899.739196ms)"],"step_count":1} {"level":"warn","ts":"2026-02-04T22:32:08.31078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"883.270226ms","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-04T22:32:08.310853Z","caller":"traceutil/trace.go:171","msg":"trace[1248797667] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:450; }","duration":"883.370976ms","start":"2026-02-04T22:32:07.427468Z","end":"2026-02-04T22:32:08.310839Z","steps":["trace[1248797667] 'agreement among raft nodes before linearized reading' (duration: 883.263026ms)"],"step_count":1} {"level":"warn","ts":"2026-02-04T22:32:08.310881Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T22:32:07.427456Z","time spent":"883.419387ms","remote":"127.0.0.1:50802","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-04T22:32:08.311142Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T22:32:07.410628Z","time spent":"900.022318ms","remote":"127.0.0.1:50802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-04T22:32:08.493148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.049383ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-02-04T22:32:08.493441Z","caller":"traceutil/trace.go:171","msg":"trace[903124835] transaction","detail":"{read_only:false; response_revision:451; number_of_response:1; }","duration":"165.767276ms","start":"2026-02-04T22:32:08.327657Z","end":"2026-02-04T22:32:08.493424Z","steps":["trace[903124835] 'process raft request' (duration: 165.585985ms)"],"step_count":1} {"level":"info","ts":"2026-02-04T22:32:08.493534Z","caller":"traceutil/trace.go:171","msg":"trace[1942586407] linearizableReadLoop","detail":"{readStateIndex:463; appliedIndex:462; }","duration":"182.914269ms","start":"2026-02-04T22:32:08.310588Z","end":"2026-02-04T22:32:08.493502Z","steps":["trace[1942586407] 'read index received' (duration: 68.482553ms)","trace[1942586407] 'applied index is now lower than readState.Index' (duration: 114.429546ms)"],"step_count":2} {"level":"warn","ts":"2026-02-04T22:32:08.493693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"893.9753ms","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-04T22:32:08.49372Z","caller":"traceutil/trace.go:171","msg":"trace[1470265460] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:451; }","duration":"894.052851ms","start":"2026-02-04T22:32:07.599659Z","end":"2026-02-04T22:32:08.493712Z","steps":["trace[1470265460] 'agreement among raft nodes before linearized reading' (duration: 893.93896ms)"],"step_count":1} {"level":"warn","ts":"2026-02-04T22:32:08.493746Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T22:32:07.599638Z","time spent":"894.101471ms","remote":"127.0.0.1:50802","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":"warn","ts":"2026-02-04T22:32:08.49386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"515.579012ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-04T22:32:08.493893Z","caller":"traceutil/trace.go:171","msg":"trace[697371153] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:451; }","duration":"515.641442ms","start":"2026-02-04T22:32:07.978242Z","end":"2026-02-04T22:32:08.493883Z","steps":["trace[697371153] 'agreement among raft nodes before linearized reading' (duration: 515.586312ms)"],"step_count":1} {"level":"warn","ts":"2026-02-04T22:32:08.493921Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T22:32:07.978226Z","time spent":"515.687792ms","remote":"127.0.0.1:50568","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-04T22:32:08.493925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"751.591021ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" ","response":"range_response_count:1 size:6894"} {"level":"info","ts":"2026-02-04T22:32:08.494037Z","caller":"traceutil/trace.go:171","msg":"trace[1107889255] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-instance; range_end:; response_count:1; response_revision:451; }","duration":"751.776673ms","start":"2026-02-04T22:32:07.742253Z","end":"2026-02-04T22:32:08.494029Z","steps":["trace[1107889255] 'agreement among raft nodes before linearized reading' (duration: 751.642202ms)"],"step_count":1} {"level":"warn","ts":"2026-02-04T22:32:08.494087Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T22:32:07.742237Z","time spent":"751.844033ms","remote":"127.0.0.1:50744","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":6918,"request content":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" "} {"level":"info","ts":"2026-02-04T22:32:18.382675Z","caller":"traceutil/trace.go:171","msg":"trace[428493573] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"338.158568ms","start":"2026-02-04T22:32:18.044501Z","end":"2026-02-04T22:32:18.382659Z","steps":["trace[428493573] 'process raft request' (duration: 337.863246ms)"],"step_count":1} {"level":"warn","ts":"2026-02-04T22:32:18.382774Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T22:32:18.044489Z","time spent":"338.232418ms","remote":"127.0.0.1:50738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4210,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-04T22:32:24.59667Z","caller":"traceutil/trace.go:171","msg":"trace[1278340862] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"173.285181ms","start":"2026-02-04T22:32:24.423372Z","end":"2026-02-04T22:32:24.596657Z","steps":["trace[1278340862] 'process raft request' (duration: 173.08971ms)"],"step_count":1} {"level":"info","ts":"2026-02-04T22:32:25.531342Z","caller":"traceutil/trace.go:171","msg":"trace[1589705142] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"332.097006ms","start":"2026-02-04T22:32:25.199224Z","end":"2026-02-04T22:32:25.531321Z","steps":["trace[1589705142] 'process raft request' (duration: 331.761094ms)"],"step_count":1} {"level":"warn","ts":"2026-02-04T22:32:25.531452Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T22:32:25.199208Z","time spent":"332.174727ms","remote":"127.0.0.1:50802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-04T22:32:26.107512Z","caller":"traceutil/trace.go:171","msg":"trace[1745938703] linearizableReadLoop","detail":"{readStateIndex:569; appliedIndex:568; }","duration":"332.706007ms","start":"2026-02-04T22:32:25.774788Z","end":"2026-02-04T22:32:26.107494Z","steps":["trace[1745938703] 'read index received' (duration: 332.523546ms)","trace[1745938703] 'applied index is now lower than readState.Index' (duration: 181.851µs)"],"step_count":2} {"level":"warn","ts":"2026-02-04T22:32:26.107669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.877528ms","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-04T22:32:26.107693Z","caller":"traceutil/trace.go:171","msg":"trace[1326695506] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:553; }","duration":"332.952858ms","start":"2026-02-04T22:32:25.774731Z","end":"2026-02-04T22:32:26.107684Z","steps":["trace[1326695506] 'agreement among raft nodes before linearized reading' (duration: 332.832268ms)"],"step_count":1} {"level":"warn","ts":"2026-02-04T22:32:26.10774Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T22:32:25.774711Z","time spent":"333.020709ms","remote":"127.0.0.1:50802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-02-04T22:32:26.107994Z","caller":"traceutil/trace.go:171","msg":"trace[2138429421] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"566.247607ms","start":"2026-02-04T22:32:25.541739Z","end":"2026-02-04T22:32:26.107987Z","steps":["trace[2138429421] 'process raft request' (duration: 565.635074ms)"],"step_count":1} {"level":"warn","ts":"2026-02-04T22:32:26.108065Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T22:32:25.541723Z","time spent":"566.294997ms","remote":"127.0.0.1:50744","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16799,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-04T22:32:27.490968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"890.251761ms","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-04T22:32:27.491039Z","caller":"traceutil/trace.go:171","msg":"trace[67551036] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:554; }","duration":"890.356322ms","start":"2026-02-04T22:32:26.600666Z","end":"2026-02-04T22:32:27.491023Z","steps":["trace[67551036] 'range keys from in-memory index tree' (duration: 890.12201ms)"],"step_count":1} {"level":"warn","ts":"2026-02-04T22:32:27.491075Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T22:32:26.600649Z","time spent":"890.417682ms","remote":"127.0.0.1:50802","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-04T22:32:27.491255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"883.357578ms","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-04T22:32:27.491281Z","caller":"traceutil/trace.go:171","msg":"trace[1223994557] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:554; }","duration":"883.391759ms","start":"2026-02-04T22:32:26.607881Z","end":"2026-02-04T22:32:27.491273Z","steps":["trace[1223994557] 'range keys from in-memory index tree' (duration: 883.298628ms)"],"step_count":1} {"level":"warn","ts":"2026-02-04T22:32:27.491305Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T22:32:26.607878Z","time spent":"883.42217ms","remote":"127.0.0.1:50802","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-04T22:32:27.491452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"883.59964ms","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-04T22:32:27.491476Z","caller":"traceutil/trace.go:171","msg":"trace[1693611645] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:554; }","duration":"883.642581ms","start":"2026-02-04T22:32:26.607827Z","end":"2026-02-04T22:32:27.491469Z","steps":["trace[1693611645] 'range keys from in-memory index tree' (duration: 883.474209ms)"],"step_count":1} {"level":"warn","ts":"2026-02-04T22:32:27.491499Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T22:32:26.607799Z","time spent":"883.695311ms","remote":"127.0.0.1:50802","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":"warn","ts":"2026-02-04T22:32:27.491937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"518.196499ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-04T22:32:27.491965Z","caller":"traceutil/trace.go:171","msg":"trace[1760244915] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:554; }","duration":"518.246469ms","start":"2026-02-04T22:32:26.973709Z","end":"2026-02-04T22:32:27.491956Z","steps":["trace[1760244915] 'range keys from in-memory index tree' (duration: 518.151549ms)"],"step_count":1} {"level":"warn","ts":"2026-02-04T22:32:27.491993Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T22:32:26.973695Z","time spent":"518.290861ms","remote":"127.0.0.1:50568","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-02-04T22:32:27.611559Z","caller":"traceutil/trace.go:171","msg":"trace[2121695593] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"111.625299ms","start":"2026-02-04T22:32:27.499916Z","end":"2026-02-04T22:32:27.611541Z","steps":["trace[2121695593] 'process raft request' (duration: 111.590519ms)"],"step_count":1} {"level":"info","ts":"2026-02-04T22:32:27.611683Z","caller":"traceutil/trace.go:171","msg":"trace[340394821] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"111.82095ms","start":"2026-02-04T22:32:27.499856Z","end":"2026-02-04T22:32:27.611677Z","steps":["trace[340394821] 'process raft request' (duration: 99.358602ms)","trace[340394821] 'compare' (duration: 12.200326ms)"],"step_count":2} {"level":"info","ts":"2026-02-04T22:32:29.956257Z","caller":"traceutil/trace.go:171","msg":"trace[933207498] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"256.579944ms","start":"2026-02-04T22:32:29.69966Z","end":"2026-02-04T22:32:29.95624Z","steps":["trace[933207498] 'process raft request' (duration: 256.482654ms)"],"step_count":1} {"level":"info","ts":"2026-02-04T22:32:47.890529Z","caller":"traceutil/trace.go:171","msg":"trace[2054074906] transaction","detail":"{read_only:false; response_revision:754; number_of_response:1; }","duration":"104.251572ms","start":"2026-02-04T22:32:47.786257Z","end":"2026-02-04T22:32:47.890509Z","steps":["trace[2054074906] 'process raft request' (duration: 104.139961ms)"],"step_count":1} {"level":"info","ts":"2026-02-04T22:32:47.893716Z","caller":"traceutil/trace.go:171","msg":"trace[1255297671] transaction","detail":"{read_only:false; response_revision:755; number_of_response:1; }","duration":"105.65415ms","start":"2026-02-04T22:32:47.788047Z","end":"2026-02-04T22:32:47.893701Z","steps":["trace[1255297671] 'process raft request' (duration: 105.58469ms)"],"step_count":1} {"level":"info","ts":"2026-02-04T22:33:46.285723Z","caller":"traceutil/trace.go:171","msg":"trace[970604678] transaction","detail":"{read_only:false; response_revision:956; number_of_response:1; }","duration":"107.6334ms","start":"2026-02-04T22:33:46.178039Z","end":"2026-02-04T22:33:46.285673Z","steps":["trace[970604678] 'process raft request' (duration: 107.569458ms)"],"step_count":1} {"level":"info","ts":"2026-02-04T22:33:46.28596Z","caller":"traceutil/trace.go:171","msg":"trace[1353345173] transaction","detail":"{read_only:false; response_revision:955; number_of_response:1; }","duration":"109.165767ms","start":"2026-02-04T22:33:46.176788Z","end":"2026-02-04T22:33:46.285953Z","steps":["trace[1353345173] 'process raft request' (duration: 108.714216ms)"],"step_count":1}